builder: release-mozilla-release_firefox_bncr_sub slave: bld-linux64-spot-438 starttime: 1461186609.05 results: success (0) revision: 53f1fadd9d33afbcd6600fb0add5b2ebb4972e45 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.047619) ========= master: http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.048044) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.048346) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.149812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.150136) ========= rm -rf scripts properties in dir /builds/slave/rel-m-rel_fx_bncr_sub-00000000/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-438.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-rel_fx_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.004400 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.204224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.204568) ========= bash -c 'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-release --rev 53f1fadd9d33afbcd6600fb0add5b2ebb4972e45 --destination scripts --debug' in dir /builds/slave/rel-m-rel_fx_bncr_sub-00000000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-release --rev 53f1fadd9d33afbcd6600fb0add5b2ebb4972e45 --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-438.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-rel_fx_bncr_sub-00000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2016-04-20 14:10:09,239 truncating revision to first 12 chars 2016-04-20 14:10:09,239 Setting DEBUG logging. 2016-04-20 14:10:09,239 attempt 1/10 2016-04-20 14:10:09,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-release/53f1fadd9d33?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 14:10:09,651 unpacking tar archive at: mozilla-release-53f1fadd9d33/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.797501) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.797799) ========= script_repo_revision: 53f1fadd9d33afbcd6600fb0add5b2ebb4972e45 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.798187) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.798451) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:10:09.810095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 4 mins, 21 secs) (at 2016-04-20 14:10:09.810380) ========= /tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_release.py --credentials-file oauth.txt --bouncer-api-prefix https://bounceradmin.mozilla.com/api --repo releases/mozilla-release in dir /builds/slave/rel-m-rel_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://bounceradmin.mozilla.com/api', '--repo', 'releases/mozilla-release'] 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-438.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-m-rel_fx_bncr_sub-00000000/buildprops.json PWD=/builds/slave/rel-m-rel_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 14:10:09 INFO - MultiFileLogger online at 20160420 14:10:09 in /builds/slave/rel-m-rel_fx_bncr_sub-00000000 14:10:09 INFO - Using buildbot properties: 14:10:09 INFO - { 14:10:09 INFO - "project": "", 14:10:09 INFO - "product": "firefox", 14:10:09 INFO - "build_number": 4, 14:10:09 INFO - "taskId": "sXhgobynSHyLYDqkwRR-FQ", 14:10:09 INFO - "repository": "", 14:10:09 INFO - "buildername": "release-mozilla-release_firefox_bncr_sub", 14:10:09 INFO - "basedir": "/builds/slave/rel-m-rel_fx_bncr_sub-00000000", 14:10:09 INFO - "buildnumber": 2, 14:10:09 INFO - "slavename": "bld-linux64-spot-438", 14:10:09 INFO - "version": "46.0", 14:10:09 INFO - "release_promotion": true, 14:10:09 INFO - "platform": null, 14:10:09 INFO - "branch": "mozilla-release", 14:10:09 INFO - "script_repo_revision": "53f1fadd9d33afbcd6600fb0add5b2ebb4972e45", 14:10:09 INFO - "master": "http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/", 14:10:09 INFO - "revision": "53f1fadd9d33afbcd6600fb0add5b2ebb4972e45", 14:10:09 INFO - "partial_versions": "44.0.2build3, 45.0.2build1, 46.0b11build1", 14:10:09 INFO - "repo_path": "releases/mozilla-release" 14:10:09 INFO - } 14:10:09 INFO - Overriding product with firefox 14:10:09 INFO - Overriding version with 46.0 14:10:09 INFO - Overriding build_number with 4 14:10:09 INFO - Overriding revision with 53f1fadd9d33afbcd6600fb0add5b2ebb4972e45 14:10:09 INFO - Run as scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_release.py --credentials-file oauth.txt --bouncer-api-prefix https://bounceradmin.mozilla.com/api --repo releases/mozilla-release 14:10:09 INFO - Dumping config to /builds/slave/rel-m-rel_fx_bncr_sub-00000000/logs/localconfig.json. 14:10:09 INFO - {'append_to_log': False, 14:10:09 INFO - 'base_work_dir': '/builds/slave/rel-m-rel_fx_bncr_sub-00000000', 14:10:09 INFO - 'bouncer-api-prefix': 'https://bounceradmin.mozilla.com/api', 14:10:09 INFO - 'build_number': 4, 14:10:09 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:09 INFO - 'config_files': ('releases/bouncer_firefox_release.py',), 14:10:09 INFO - 'credentials_file': 'oauth.txt', 14:10:09 INFO - 'log_level': 'info', 14:10:09 INFO - 'log_to_console': True, 14:10:09 INFO - 'opt_config_files': (), 14:10:09 INFO - 'partials': {'candidates-dir': {'add-locales': True, 14:10:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 14:10:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:10:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 14:10:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:10:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 14:10:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:10:09 INFO - 'win32': {'bouncer-platform': 'win', 14:10:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:10:09 INFO - 'win64': {'bouncer-platform': 'win64', 14:10:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 14:10:09 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Partial-%(prev_version)sbuild%(prev_build_number)s', 14:10:09 INFO - 'ssl-only': False}, 14:10:09 INFO - 'releases-dir': {'add-locales': True, 14:10:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:10:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:10:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:10:09 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.opensolaris-i386.partial.mar'}, 14:10:09 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.opensolaris-sparc.partial.mar'}, 14:10:09 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.solaris-i386.partial.mar'}, 14:10:09 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.solaris-sparc.partial.mar'}, 14:10:09 INFO - 'win32': {'bouncer-platform': 'win', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:10:09 INFO - 'win64': {'bouncer-platform': 'win64', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 14:10:09 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s', 14:10:09 INFO - 'ssl-only': False}}, 14:10:09 INFO - 'prev_versions': (u'44.0.2build3', u'45.0.2build1', u'46.0b11build1'), 14:10:09 INFO - 'product': u'firefox', 14:10:09 INFO - 'products': {'complete-mar': {'add-locales': True, 14:10:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 14:10:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 14:10:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 14:10:09 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.complete.mar'}, 14:10:09 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.complete.mar'}, 14:10:09 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.complete.mar'}, 14:10:09 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.complete.mar'}, 14:10:09 INFO - 'win32': {'bouncer-platform': 'win', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 14:10:09 INFO - 'win64': {'bouncer-platform': 'win64', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 14:10:09 INFO - 'product-name': 'Firefox-%(version)s-Complete', 14:10:09 INFO - 'ssl-only': False}, 14:10:09 INFO - 'complete-mar-candidates': {'add-locales': True, 14:10:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 14:10:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 14:10:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 14:10:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 14:10:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 14:10:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 14:10:09 INFO - 'win32': {'bouncer-platform': 'win', 14:10:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 14:10:09 INFO - 'win64': {'bouncer-platform': 'win64', 14:10:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 14:10:09 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete', 14:10:09 INFO - 'ssl-only': False}, 14:10:09 INFO - 'installer': {'add-locales': True, 14:10:09 INFO - 'alias': 'firefox-latest', 14:10:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 14:10:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 14:10:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 14:10:09 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.tar.bz2'}, 14:10:09 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.tar.bz2'}, 14:10:09 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.tar.bz2'}, 14:10:09 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.tar.bz2'}, 14:10:09 INFO - 'win32': {'bouncer-platform': 'win', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 14:10:09 INFO - 'win64': {'bouncer-platform': 'win64', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 14:10:09 INFO - 'product-name': 'Firefox-%(version)s', 14:10:09 INFO - 'ssl-only': False}, 14:10:09 INFO - 'installer-ssl': {'add-locales': True, 14:10:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 14:10:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 14:10:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 14:10:09 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.tar.bz2'}, 14:10:09 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.tar.bz2'}, 14:10:09 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 14:10:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.tar.bz2'}, 14:10:09 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 14:10:10 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.tar.bz2'}, 14:10:10 INFO - 'win32': {'bouncer-platform': 'win', 14:10:10 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 14:10:10 INFO - 'win64': {'bouncer-platform': 'win64', 14:10:10 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 14:10:10 INFO - 'product-name': 'Firefox-%(version)s-SSL', 14:10:10 INFO - 'ssl-only': True}, 14:10:10 INFO - 'stub-installer': {'add-locales': True, 14:10:10 INFO - 'alias': 'firefox-stub', 14:10:10 INFO - 'paths': {'win32': {'bouncer-platform': 'win', 14:10:10 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}, 14:10:10 INFO - 'win64': {'bouncer-platform': 'win64', 14:10:10 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}}, 14:10:10 INFO - 'product-name': 'Firefox-%(version)s-stub', 14:10:10 INFO - 'ssl-only': True}}, 14:10:10 INFO - 'repo': 'releases/mozilla-release', 14:10:10 INFO - 'revision': u'53f1fadd9d33afbcd6600fb0add5b2ebb4972e45', 14:10:10 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales', 14:10:10 INFO - 'version': u'46.0', 14:10:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:10 INFO - 'work_dir': 'build'} 14:10:10 INFO - ##### 14:10:10 INFO - ##### Running clobber step. 14:10:10 INFO - ##### 14:10:10 INFO - Running main action method: clobber 14:10:10 INFO - rmtree: /builds/slave/rel-m-rel_fx_bncr_sub-00000000/build 14:10:10 INFO - ##### 14:10:10 INFO - ##### Running download-shipped-locales step. 14:10:10 INFO - ##### 14:10:10 INFO - Running main action method: download_shipped_locales 14:10:10 INFO - mkdir: /builds/slave/rel-m-rel_fx_bncr_sub-00000000/build 14:10:10 INFO - Downloading https://hg.mozilla.org/releases/mozilla-release/raw-file/53f1fadd9d33afbcd6600fb0add5b2ebb4972e45/browser/locales/shipped-locales to /builds/slave/rel-m-rel_fx_bncr_sub-00000000/build/shipped-locales 14:10:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://hg.mozilla.org/releases/mozilla-release/raw-file/53f1fadd9d33afbcd6600fb0add5b2ebb4972e45/browser/locales/shipped-locales', 'file_name': '/builds/slave/rel-m-rel_fx_bncr_sub-00000000/build/shipped-locales'}, attempt #1 14:10:10 INFO - Downloaded 369 bytes. 14:10:10 INFO - Reading from file /builds/slave/rel-m-rel_fx_bncr_sub-00000000/build/shipped-locales 14:10:10 INFO - Contents: 14:10:10 INFO - ach 14:10:10 INFO - af 14:10:10 INFO - an 14:10:10 INFO - ar 14:10:10 INFO - as 14:10:10 INFO - ast 14:10:10 INFO - az 14:10:10 INFO - be 14:10:10 INFO - bg 14:10:10 INFO - bn-BD 14:10:10 INFO - bn-IN 14:10:10 INFO - br 14:10:10 INFO - bs 14:10:10 INFO - ca 14:10:10 INFO - cs 14:10:10 INFO - cy 14:10:10 INFO - da 14:10:10 INFO - de 14:10:10 INFO - dsb 14:10:10 INFO - el 14:10:10 INFO - en-GB 14:10:10 INFO - en-US 14:10:10 INFO - en-ZA 14:10:10 INFO - eo 14:10:10 INFO - es-AR 14:10:10 INFO - es-CL 14:10:10 INFO - es-ES 14:10:10 INFO - es-MX 14:10:10 INFO - et 14:10:10 INFO - eu 14:10:10 INFO - fa 14:10:10 INFO - ff 14:10:10 INFO - fi 14:10:10 INFO - fr 14:10:10 INFO - fy-NL 14:10:10 INFO - ga-IE 14:10:10 INFO - gd 14:10:10 INFO - gl 14:10:10 INFO - gn 14:10:10 INFO - gu-IN 14:10:10 INFO - he 14:10:10 INFO - hi-IN 14:10:10 INFO - hr 14:10:10 INFO - hsb 14:10:10 INFO - hu 14:10:10 INFO - hy-AM 14:10:10 INFO - id 14:10:10 INFO - is 14:10:10 INFO - it 14:10:10 INFO - ja linux win32 14:10:10 INFO - ja-JP-mac osx 14:10:10 INFO - kk 14:10:10 INFO - km 14:10:10 INFO - kn 14:10:10 INFO - ko 14:10:10 INFO - lij 14:10:10 INFO - lt 14:10:10 INFO - lv 14:10:10 INFO - mai 14:10:10 INFO - mk 14:10:10 INFO - ml 14:10:10 INFO - mr 14:10:10 INFO - ms 14:10:10 INFO - nb-NO 14:10:10 INFO - nl 14:10:10 INFO - nn-NO 14:10:10 INFO - or 14:10:10 INFO - pa-IN 14:10:10 INFO - pl 14:10:10 INFO - pt-BR 14:10:10 INFO - pt-PT 14:10:10 INFO - rm 14:10:10 INFO - ro 14:10:10 INFO - ru 14:10:10 INFO - si 14:10:10 INFO - sk 14:10:10 INFO - sl 14:10:10 INFO - son 14:10:10 INFO - sq 14:10:10 INFO - sr 14:10:10 INFO - sv-SE 14:10:10 INFO - ta 14:10:10 INFO - te 14:10:10 INFO - th 14:10:10 INFO - tr 14:10:10 INFO - uk 14:10:10 INFO - uz 14:10:10 INFO - vi 14:10:10 INFO - xh 14:10:10 INFO - zh-CN 14:10:10 INFO - zh-TW 14:10:10 INFO - ##### 14:10:10 INFO - ##### Running submit step. 14:10:10 INFO - ##### 14:10:10 INFO - Running main action method: submit 14:10:10 INFO - Checking if Firefox-46.0-Complete already exists 14:10:10 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Complete', None), kwargs: {}, attempt #1 14:10:10 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-46.0-Complete 14:10:11 INFO - Server response 14:10:11 INFO - 14:10:11 INFO - Products found: 1 14:10:11 WARNING - Product Firefox-46.0-Complete already exists. Skipping... 14:10:11 INFO - Checking if Firefox-46.0build4-Complete already exists 14:10:11 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build4-Complete', None), kwargs: {}, attempt #1 14:10:11 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-46.0build4-Complete 14:10:11 INFO - Server response 14:10:11 INFO - 14:10:11 INFO - Products found: 0 14:10:11 INFO - Adding complete-mar-candidates... 14:10:11 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': u'Firefox-46.0build4-Complete'}), kwargs: {}, attempt #1 14:10:11 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-46.0build4-Complete 14:10:11 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/ 14:10:12 WARNING - Cannot access https://bounceradmin.mozilla.com/api/product_add/ 14:10:12 WARNING - Returned page source: 14:10:12 WARNING - invalid language code(s) 14:10:12 INFO - retry: attempt #1 caught exception: HTTP Error 400: BAD REQUEST 14:10:12 INFO - retry: Failed, sleeping 60 seconds before retrying 14:11:12 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': u'Firefox-46.0build4-Complete'}), kwargs: {}, attempt #2 14:11:12 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-46.0build4-Complete 14:11:12 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/ 14:11:12 WARNING - Cannot access https://bounceradmin.mozilla.com/api/product_add/ 14:11:12 WARNING - Returned page source: 14:11:12 WARNING - invalid language code(s) 14:11:12 INFO - retry: attempt #2 caught exception: HTTP Error 400: BAD REQUEST 14:11:12 INFO - retry: Failed, sleeping 120 seconds before retrying 14:13:12 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': u'Firefox-46.0build4-Complete'}), kwargs: {}, attempt #3 14:13:12 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-46.0build4-Complete 14:13:12 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/ 14:13:13 INFO - Server response 14:13:13 INFO - 14:13:13 INFO - Adding paths... 14:13:13 INFO - linux (linux): /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-46.0.complete.mar 14:13:13 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build4-Complete', 'os': 'linux'}), kwargs: {}, attempt #1 14:13:13 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build4-Complete&os=linux 14:13:13 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:13:14 INFO - Server response 14:13:14 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-46.0.complete.mar 14:13:14 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-46.0.complete.mar 14:13:14 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build4-Complete', 'os': 'linux64'}), kwargs: {}, attempt #1 14:13:14 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build4-Complete&os=linux64 14:13:14 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:13:14 INFO - Server response 14:13:14 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-46.0.complete.mar 14:13:14 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-46.0.complete.mar 14:13:14 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build4-Complete', 'os': 'osx'}), kwargs: {}, attempt #1 14:13:14 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build4-Complete&os=osx 14:13:14 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:13:15 INFO - Server response 14:13:15 INFO - /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-46.0.complete.mar 14:13:15 INFO - win32 (win): /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-46.0.complete.mar 14:13:15 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build4-Complete', 'os': 'win'}), kwargs: {}, attempt #1 14:13:15 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build4-Complete&os=win 14:13:15 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:13:15 INFO - Server response 14:13:15 INFO - /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-46.0.complete.mar 14:13:15 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-46.0.complete.mar 14:13:15 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build4-Complete', 'os': 'win64'}), kwargs: {}, attempt #1 14:13:15 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build4-Complete&os=win64 14:13:15 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:13:16 INFO - Server response 14:13:16 INFO - /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-46.0.complete.mar 14:13:16 INFO - Checking if Firefox-46.0 already exists 14:13:16 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0', None), kwargs: {}, attempt #1 14:13:16 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-46.0 14:13:16 INFO - Server response 14:13:16 INFO - 14:13:16 INFO - Products found: 1 14:13:16 WARNING - Product Firefox-46.0 already exists. Skipping... 14:13:16 INFO - Checking if Firefox-46.0-SSL already exists 14:13:16 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-SSL', None), kwargs: {}, attempt #1 14:13:16 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-46.0-SSL 14:13:16 INFO - Server response 14:13:16 INFO - 14:13:16 INFO - Products found: 1 14:13:16 WARNING - Product Firefox-46.0-SSL already exists. Skipping... 14:13:16 INFO - Checking if Firefox-46.0-stub already exists 14:13:16 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-stub', None), kwargs: {}, attempt #1 14:13:16 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-46.0-stub 14:13:17 INFO - Server response 14:13:17 INFO - 14:13:17 INFO - Products found: 1 14:13:17 WARNING - Product Firefox-46.0-stub already exists. Skipping... 14:13:17 INFO - Checking if Firefox-46.0build4-Partial-44.0.2build3 already exists 14:13:17 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build4-Partial-44.0.2build3', None), kwargs: {}, attempt #1 14:13:17 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-46.0build4-Partial-44.0.2build3 14:13:17 INFO - Server response 14:13:17 INFO - 14:13:17 INFO - Products found: 0 14:13:17 INFO - Adding partial updates for Firefox-46.0build4-Partial-44.0.2build3 14:13:17 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': u'Firefox-46.0build4-Partial-44.0.2build3'}), kwargs: {}, attempt #1 14:13:17 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-46.0build4-Partial-44.0.2build3 14:13:17 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/ 14:13:18 WARNING - Cannot access https://bounceradmin.mozilla.com/api/product_add/ 14:13:18 WARNING - Returned page source: 14:13:18 WARNING - invalid language code(s) 14:13:18 INFO - retry: attempt #1 caught exception: HTTP Error 400: BAD REQUEST 14:13:18 INFO - retry: Failed, sleeping 60 seconds before retrying 14:14:18 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': u'Firefox-46.0build4-Partial-44.0.2build3'}), kwargs: {}, attempt #2 14:14:18 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-46.0build4-Partial-44.0.2build3 14:14:18 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/ 14:14:19 INFO - Server response 14:14:19 INFO - 14:14:19 INFO - linux (linux): /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-44.0.2-46.0.partial.mar 14:14:19 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-44.0.2-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-44.0.2build3', 'os': 'linux'}), kwargs: {}, attempt #1 14:14:19 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-44.0.2-46.0.partial.mar&product=Firefox-46.0build4-Partial-44.0.2build3&os=linux 14:14:19 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:20 INFO - Server response 14:14:20 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-44.0.2-46.0.partial.mar 14:14:20 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-44.0.2-46.0.partial.mar 14:14:20 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-44.0.2-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-44.0.2build3', 'os': 'linux64'}), kwargs: {}, attempt #1 14:14:20 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-44.0.2-46.0.partial.mar&product=Firefox-46.0build4-Partial-44.0.2build3&os=linux64 14:14:20 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:20 INFO - Server response 14:14:20 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-44.0.2-46.0.partial.mar 14:14:20 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-44.0.2-46.0.partial.mar 14:14:20 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-44.0.2-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-44.0.2build3', 'os': 'osx'}), kwargs: {}, attempt #1 14:14:20 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-44.0.2-46.0.partial.mar&product=Firefox-46.0build4-Partial-44.0.2build3&os=osx 14:14:20 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:20 INFO - Server response 14:14:20 INFO - /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-44.0.2-46.0.partial.mar 14:14:20 INFO - win32 (win): /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-44.0.2-46.0.partial.mar 14:14:20 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-44.0.2-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-44.0.2build3', 'os': 'win'}), kwargs: {}, attempt #1 14:14:20 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-44.0.2-46.0.partial.mar&product=Firefox-46.0build4-Partial-44.0.2build3&os=win 14:14:20 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:21 INFO - Server response 14:14:21 INFO - /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-44.0.2-46.0.partial.mar 14:14:21 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-44.0.2-46.0.partial.mar 14:14:21 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-44.0.2-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-44.0.2build3', 'os': 'win64'}), kwargs: {}, attempt #1 14:14:21 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-44.0.2-46.0.partial.mar&product=Firefox-46.0build4-Partial-44.0.2build3&os=win64 14:14:21 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:21 INFO - Server response 14:14:21 INFO - /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-44.0.2-46.0.partial.mar 14:14:21 INFO - Checking if Firefox-46.0build4-Partial-45.0.2build1 already exists 14:14:21 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build4-Partial-45.0.2build1', None), kwargs: {}, attempt #1 14:14:21 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-46.0build4-Partial-45.0.2build1 14:14:22 INFO - Server response 14:14:22 INFO - 14:14:22 INFO - Products found: 0 14:14:22 INFO - Adding partial updates for Firefox-46.0build4-Partial-45.0.2build1 14:14:22 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': u'Firefox-46.0build4-Partial-45.0.2build1'}), kwargs: {}, attempt #1 14:14:22 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-46.0build4-Partial-45.0.2build1 14:14:22 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/ 14:14:23 INFO - Server response 14:14:23 INFO - 14:14:23 INFO - linux (linux): /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-45.0.2-46.0.partial.mar 14:14:23 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-45.0.2-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-45.0.2build1', 'os': 'linux'}), kwargs: {}, attempt #1 14:14:23 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-45.0.2-46.0.partial.mar&product=Firefox-46.0build4-Partial-45.0.2build1&os=linux 14:14:23 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:24 INFO - Server response 14:14:24 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-45.0.2-46.0.partial.mar 14:14:24 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-45.0.2-46.0.partial.mar 14:14:24 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-45.0.2-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-45.0.2build1', 'os': 'linux64'}), kwargs: {}, attempt #1 14:14:24 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-45.0.2-46.0.partial.mar&product=Firefox-46.0build4-Partial-45.0.2build1&os=linux64 14:14:24 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:24 INFO - Server response 14:14:24 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-45.0.2-46.0.partial.mar 14:14:24 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-45.0.2-46.0.partial.mar 14:14:24 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-45.0.2-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-45.0.2build1', 'os': 'osx'}), kwargs: {}, attempt #1 14:14:24 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-45.0.2-46.0.partial.mar&product=Firefox-46.0build4-Partial-45.0.2build1&os=osx 14:14:24 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:24 INFO - Server response 14:14:24 INFO - /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-45.0.2-46.0.partial.mar 14:14:24 INFO - win32 (win): /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-45.0.2-46.0.partial.mar 14:14:24 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-45.0.2-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-45.0.2build1', 'os': 'win'}), kwargs: {}, attempt #1 14:14:24 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-45.0.2-46.0.partial.mar&product=Firefox-46.0build4-Partial-45.0.2build1&os=win 14:14:24 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:25 INFO - Server response 14:14:25 INFO - /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-45.0.2-46.0.partial.mar 14:14:25 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-45.0.2-46.0.partial.mar 14:14:25 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-45.0.2-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-45.0.2build1', 'os': 'win64'}), kwargs: {}, attempt #1 14:14:25 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-45.0.2-46.0.partial.mar&product=Firefox-46.0build4-Partial-45.0.2build1&os=win64 14:14:25 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:25 INFO - Server response 14:14:25 INFO - /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-45.0.2-46.0.partial.mar 14:14:25 INFO - Checking if Firefox-46.0build4-Partial-46.0b11build1 already exists 14:14:25 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build4-Partial-46.0b11build1', None), kwargs: {}, attempt #1 14:14:25 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-46.0build4-Partial-46.0b11build1 14:14:26 INFO - Server response 14:14:26 INFO - 14:14:26 INFO - Products found: 0 14:14:26 INFO - Adding partial updates for Firefox-46.0build4-Partial-46.0b11build1 14:14:26 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': u'Firefox-46.0build4-Partial-46.0b11build1'}), kwargs: {}, attempt #1 14:14:26 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-46.0build4-Partial-46.0b11build1 14:14:26 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/ 14:14:27 INFO - Server response 14:14:27 INFO - 14:14:27 INFO - linux (linux): /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-46.0b11-46.0.partial.mar 14:14:27 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-46.0b11-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-46.0b11build1', 'os': 'linux'}), kwargs: {}, attempt #1 14:14:27 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-46.0b11-46.0.partial.mar&product=Firefox-46.0build4-Partial-46.0b11build1&os=linux 14:14:27 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:28 INFO - Server response 14:14:28 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-46.0b11-46.0.partial.mar 14:14:28 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-46.0b11-46.0.partial.mar 14:14:28 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-46.0b11-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-46.0b11build1', 'os': 'linux64'}), kwargs: {}, attempt #1 14:14:28 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-46.0b11-46.0.partial.mar&product=Firefox-46.0build4-Partial-46.0b11build1&os=linux64 14:14:28 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:28 INFO - Server response 14:14:28 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-46.0b11-46.0.partial.mar 14:14:28 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-46.0b11-46.0.partial.mar 14:14:28 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-46.0b11-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-46.0b11build1', 'os': 'osx'}), kwargs: {}, attempt #1 14:14:28 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-46.0b11-46.0.partial.mar&product=Firefox-46.0build4-Partial-46.0b11build1&os=osx 14:14:28 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:28 INFO - Server response 14:14:28 INFO - /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-46.0b11-46.0.partial.mar 14:14:28 INFO - win32 (win): /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-46.0b11-46.0.partial.mar 14:14:28 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-46.0b11-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-46.0b11build1', 'os': 'win'}), kwargs: {}, attempt #1 14:14:28 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-46.0b11-46.0.partial.mar&product=Firefox-46.0build4-Partial-46.0b11build1&os=win 14:14:28 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:29 INFO - Server response 14:14:29 INFO - /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-46.0b11-46.0.partial.mar 14:14:29 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-46.0b11-46.0.partial.mar 14:14:29 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-46.0b11-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-46.0b11build1', 'os': 'win64'}), kwargs: {}, attempt #1 14:14:29 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-46.0b11-46.0.partial.mar&product=Firefox-46.0build4-Partial-46.0b11build1&os=win64 14:14:29 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/ 14:14:29 INFO - Server response 14:14:29 INFO - /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-46.0b11-46.0.partial.mar 14:14:29 INFO - Checking if Firefox-46.0-Partial-44.0.2 already exists 14:14:29 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Partial-44.0.2', None), kwargs: {}, attempt #1 14:14:29 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-46.0-Partial-44.0.2 14:14:30 INFO - Server response 14:14:30 INFO - 14:14:30 INFO - Products found: 1 14:14:30 WARNING - Product Firefox-46.0-Partial-44.0.2 already exists. Skipping... 14:14:30 INFO - Checking if Firefox-46.0-Partial-45.0.2 already exists 14:14:30 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Partial-45.0.2', None), kwargs: {}, attempt #1 14:14:30 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-46.0-Partial-45.0.2 14:14:30 INFO - Server response 14:14:30 INFO - 14:14:30 INFO - Products found: 1 14:14:30 WARNING - Product Firefox-46.0-Partial-45.0.2 already exists. Skipping... 14:14:30 INFO - Checking if Firefox-46.0-Partial-46.0b11 already exists 14:14:30 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Partial-46.0b11', None), kwargs: {}, attempt #1 14:14:30 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-46.0-Partial-46.0b11 14:14:30 INFO - Server response 14:14:30 INFO - 14:14:30 INFO - Products found: 1 14:14:30 WARNING - Product Firefox-46.0-Partial-46.0b11 already exists. Skipping... 14:14:30 INFO - Running post-run listener: copy_logs_to_upload_dir 14:14:30 INFO - Copying logs to upload dir... 14:14:30 INFO - mkdir: /builds/slave/rel-m-rel_fx_bncr_sub-00000000/build/upload/logs 14:14:30 INFO - Copying logs to upload dir... Traceback (most recent call last): File "/builds/slave/rel-m-rel_fx_bncr_sub-00000000/scripts/mozharness/mozilla/bouncer/submitter.py", line 57, in _api_call res = urllib2.urlopen(request, timeout=60).read() File "/tools/python27/lib/python2.7/urllib2.py", line 126, in urlopen return _opener.open(url, data, timeout) File "/tools/python27/lib/python2.7/urllib2.py", line 406, in open response = meth(req, response) File "/tools/python27/lib/python2.7/urllib2.py", line 519, in http_response 'http', request, response, code, msg, hdrs) File "/tools/python27/lib/python2.7/urllib2.py", line 444, in error return self._call_chain(*args) File "/tools/python27/lib/python2.7/urllib2.py", line 378, in _call_chain result = func(*args) File "/tools/python27/lib/python2.7/urllib2.py", line 527, 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-rel_fx_bncr_sub-00000000/scripts/mozharness/mozilla/bouncer/submitter.py", line 57, in _api_call res = urllib2.urlopen(request, timeout=60).read() File "/tools/python27/lib/python2.7/urllib2.py", line 126, in urlopen return _opener.open(url, data, timeout) File "/tools/python27/lib/python2.7/urllib2.py", line 406, in open response = meth(req, response) File "/tools/python27/lib/python2.7/urllib2.py", line 519, in http_response 'http', request, response, code, msg, hdrs) File "/tools/python27/lib/python2.7/urllib2.py", line 444, in error return self._call_chain(*args) File "/tools/python27/lib/python2.7/urllib2.py", line 378, in _call_chain result = func(*args) File "/tools/python27/lib/python2.7/urllib2.py", line 527, 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-rel_fx_bncr_sub-00000000/scripts/mozharness/mozilla/bouncer/submitter.py", line 57, in _api_call res = urllib2.urlopen(request, timeout=60).read() File "/tools/python27/lib/python2.7/urllib2.py", line 126, in urlopen return _opener.open(url, data, timeout) File "/tools/python27/lib/python2.7/urllib2.py", line 406, in open response = meth(req, response) File "/tools/python27/lib/python2.7/urllib2.py", line 519, in http_response 'http', request, response, code, msg, hdrs) File "/tools/python27/lib/python2.7/urllib2.py", line 444, in error return self._call_chain(*args) File "/tools/python27/lib/python2.7/urllib2.py", line 378, in _call_chain result = func(*args) File "/tools/python27/lib/python2.7/urllib2.py", line 527, 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=261.211681 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 4 mins, 21 secs) (at 2016-04-20 14:14:31.050252) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2016-04-20 14:14:31.053315) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-m-rel_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-438.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-rel_fx_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.006199 ========= master_lag: 0.04 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2016-04-20 14:14:31.103818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:14:31.104159) ========= rm -f oauth.txt in dir /builds/slave/rel-m-rel_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-438.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-rel_fx_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.004085 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:14:31.153436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:14:31.153747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:14:31.154060) ========= ========= Total master_lag: 0.18 =========