builder: release-jamun_firefox_bncr_sub slave: bld-linux64-spot-470 starttime: 1460250868.87 results: success (0) revision: 18e3a714b829bdfd785810c16cc8469fcbe23d20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:28.871261) ========= master: http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:28.871617) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:28.871896) ========= bash -c pwd in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-470.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-jamun_fx_bncr_sub-00000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False /builds/slave/rel-jamun_fx_bncr_sub-00000000 program finished with exit code 0 elapsedTime=0.004230 basedir: '/builds/slave/rel-jamun_fx_bncr_sub-00000000' ========= master_lag: 0.75 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:29.623836) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:29.624156) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:30.026094) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:30.026371) ========= rm -rf properties in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-470.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-jamun_fx_bncr_sub-00000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002875 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:30.055887) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:30.056161) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:30.056617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:30.056885) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-470.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-jamun_fx_bncr_sub-00000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False --2016-04-09 18:14:30-- 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% 72.9M=0s 2016-04-09 18:14:30 (72.9 MB/s) - ‘archiver_client.py’ saved [12141/12141] program finished with exit code 0 elapsedTime=0.429398 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:30.761847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:30.762141) ========= rm -rf scripts in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-470.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-jamun_fx_bncr_sub-00000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002835 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:30.869176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:30.869515) ========= bash -c 'python archiver_client.py mozharness --repo projects/jamun --rev 18e3a714b829bdfd785810c16cc8469fcbe23d20 --destination scripts --debug' in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/jamun --rev 18e3a714b829bdfd785810c16cc8469fcbe23d20 --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-470.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-jamun_fx_bncr_sub-00000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2016-04-09 18:14:30,919 truncating revision to first 12 chars 2016-04-09 18:14:30,919 Setting DEBUG logging. 2016-04-09 18:14:30,919 attempt 1/10 2016-04-09 18:14:30,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/jamun/18e3a714b829?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-09 18:14:31,267 unpacking tar archive at: jamun-18e3a714b829/testing/mozharness/ program finished with exit code 0 elapsedTime=0.500653 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:31.413684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:31.413967) ========= echo 18e3a714b829bdfd785810c16cc8469fcbe23d20 in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '18e3a714b829bdfd785810c16cc8469fcbe23d20'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-470.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-jamun_fx_bncr_sub-00000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 18e3a714b829bdfd785810c16cc8469fcbe23d20 program finished with exit code 0 elapsedTime=0.002764 script_repo_revision: '18e3a714b829bdfd785810c16cc8469fcbe23d20' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:31.462787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:31.463061) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:31.539102) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 15 secs) (at 2016-04-09 18:14:31.539391) ========= /tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_release.py --credentials-file oauth.txt --bouncer-api-prefix https://admin-bouncer.stage.mozaws.net/api --repo projects/jamun in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 3600 secs) (maxTime 14400 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/bouncer_submitter.py', '-c', 'releases/bouncer_firefox_release.py', '--credentials-file', 'oauth.txt', '--bouncer-api-prefix', 'https://admin-bouncer.stage.mozaws.net/api', '--repo', 'projects/jamun'] environment: CCACHE_COMPRESS=1 CCACHE_DIR=/builds/ccache CCACHE_HASHDIR= CCACHE_UMASK=002 DISPLAY=:2 G_BROKEN_FILENAMES=1 HG_SHARE_BASE_DIR=/builds/hg-shared HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-470.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LC_ALL=C LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld MOZ_AUTOMATION=1 MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_OBJDIR=obj-firefox PATH=/tools/buildbot/bin:/usr/local/bin:/usr/lib64/ccache:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/tools/git/bin:/tools/python27/bin:/tools/python27-mercurial/bin:/home/cltbld/bin PROPERTIES_FILE=/builds/slave/rel-jamun_fx_bncr_sub-00000000/buildprops.json PWD=/builds/slave/rel-jamun_fx_bncr_sub-00000000 SHELL=/bin/bash SHLVL=1 TERM=linux TINDERBOX_OUTPUT=1 TMOUT=86400 TOOLTOOL_CACHE=/builds/tooltool_cache TOOLTOOL_HOME=/builds USER=cltbld _=/tools/buildbot/bin/python using PTY: False 18:14:31 INFO - MultiFileLogger online at 20160409 18:14:31 in /builds/slave/rel-jamun_fx_bncr_sub-00000000 18:14:31 INFO - Using buildbot properties: 18:14:31 INFO - { 18:14:31 INFO - "project": "", 18:14:31 INFO - "product": "firefox", 18:14:31 INFO - "build_number": 4, 18:14:31 INFO - "taskId": "0KYBAGM4RMK7aY8M249l8w", 18:14:31 INFO - "repository": "", 18:14:31 INFO - "buildername": "release-jamun_firefox_bncr_sub", 18:14:31 INFO - "basedir": "/builds/slave/rel-jamun_fx_bncr_sub-00000000", 18:14:31 INFO - "buildnumber": 2, 18:14:31 INFO - "slavename": "bld-linux64-spot-470", 18:14:31 INFO - "version": "46.0", 18:14:31 INFO - "release_promotion": true, 18:14:31 INFO - "platform": null, 18:14:31 INFO - "branch": "jamun", 18:14:31 INFO - "script_repo_revision": "18e3a714b829bdfd785810c16cc8469fcbe23d20", 18:14:31 INFO - "master": "http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/", 18:14:31 INFO - "revision": "18e3a714b829bdfd785810c16cc8469fcbe23d20", 18:14:31 INFO - "partial_versions": "44.0build3, 45.0build2", 18:14:31 INFO - "repo_path": "projects/jamun" 18:14:31 INFO - } 18:14:31 INFO - Overriding product with firefox 18:14:31 INFO - Overriding version with 46.0 18:14:31 INFO - Overriding build_number with 4 18:14:31 INFO - Overriding revision with 18e3a714b829bdfd785810c16cc8469fcbe23d20 18:14:31 INFO - Run as scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_release.py --credentials-file oauth.txt --bouncer-api-prefix https://admin-bouncer.stage.mozaws.net/api --repo projects/jamun 18:14:31 INFO - Dumping config to /builds/slave/rel-jamun_fx_bncr_sub-00000000/logs/localconfig.json. 18:14:31 INFO - {'append_to_log': False, 18:14:31 INFO - 'base_work_dir': '/builds/slave/rel-jamun_fx_bncr_sub-00000000', 18:14:31 INFO - 'bouncer-api-prefix': 'https://admin-bouncer.stage.mozaws.net/api', 18:14:31 INFO - 'build_number': 4, 18:14:31 INFO - 'buildbot_json_path': 'buildprops.json', 18:14:31 INFO - 'config_files': ('releases/bouncer_firefox_release.py',), 18:14:31 INFO - 'credentials_file': 'oauth.txt', 18:14:31 INFO - 'log_level': 'info', 18:14:31 INFO - 'log_to_console': True, 18:14:31 INFO - 'opt_config_files': (), 18:14:31 INFO - 'partials': {'candidates-dir': {'add-locales': False, 18:14:31 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 18:14:31 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 18:14:31 INFO - 'linux64': {'bouncer-platform': 'linux64', 18:14:31 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 18:14:31 INFO - 'macosx64': {'bouncer-platform': 'osx', 18:14:31 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 18:14:31 INFO - 'win32': {'bouncer-platform': 'win', 18:14:31 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 18:14:31 INFO - 'win64': {'bouncer-platform': 'win64', 18:14:31 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 18:14:31 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Partial-%(prev_version)sbuild%(prev_build_number)s', 18:14:31 INFO - 'ssl-only': False}, 18:14:31 INFO - 'releases-dir': {'add-locales': False, 18:14:31 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 18:14:31 INFO - 'linux64': {'bouncer-platform': 'linux64', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 18:14:31 INFO - 'macosx64': {'bouncer-platform': 'osx', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 18:14:31 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.opensolaris-i386.partial.mar'}, 18:14:31 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.opensolaris-sparc.partial.mar'}, 18:14:31 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.solaris-i386.partial.mar'}, 18:14:31 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.solaris-sparc.partial.mar'}, 18:14:31 INFO - 'win32': {'bouncer-platform': 'win', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 18:14:31 INFO - 'win64': {'bouncer-platform': 'win64', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 18:14:31 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s', 18:14:31 INFO - 'ssl-only': False}}, 18:14:31 INFO - 'prev_versions': (u'44.0build3', u'45.0build2'), 18:14:31 INFO - 'product': u'firefox', 18:14:31 INFO - 'products': {'complete-mar': {'add-locales': False, 18:14:31 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 18:14:31 INFO - 'linux64': {'bouncer-platform': 'linux64', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 18:14:31 INFO - 'macosx64': {'bouncer-platform': 'osx', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 18:14:31 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.complete.mar'}, 18:14:31 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.complete.mar'}, 18:14:31 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.complete.mar'}, 18:14:31 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.complete.mar'}, 18:14:31 INFO - 'win32': {'bouncer-platform': 'win', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 18:14:31 INFO - 'win64': {'bouncer-platform': 'win64', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 18:14:31 INFO - 'product-name': 'Firefox-%(version)s-Complete', 18:14:31 INFO - 'ssl-only': False}, 18:14:31 INFO - 'complete-mar-candidates': {'add-locales': False, 18:14:31 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 18:14:31 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 18:14:31 INFO - 'linux64': {'bouncer-platform': 'linux64', 18:14:31 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 18:14:31 INFO - 'macosx64': {'bouncer-platform': 'osx', 18:14:31 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 18:14:31 INFO - 'win32': {'bouncer-platform': 'win', 18:14:31 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 18:14:31 INFO - 'win64': {'bouncer-platform': 'win64', 18:14:31 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 18:14:31 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete', 18:14:31 INFO - 'ssl-only': False}, 18:14:31 INFO - 'installer': {'add-locales': False, 18:14:31 INFO - 'alias': 'firefox-latest', 18:14:31 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 18:14:31 INFO - 'linux64': {'bouncer-platform': 'linux64', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 18:14:31 INFO - 'macosx64': {'bouncer-platform': 'osx', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 18:14:31 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.tar.bz2'}, 18:14:31 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.tar.bz2'}, 18:14:31 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.tar.bz2'}, 18:14:31 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.tar.bz2'}, 18:14:31 INFO - 'win32': {'bouncer-platform': 'win', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 18:14:31 INFO - 'win64': {'bouncer-platform': 'win64', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 18:14:31 INFO - 'product-name': 'Firefox-%(version)s', 18:14:31 INFO - 'ssl-only': False}, 18:14:31 INFO - 'installer-ssl': {'add-locales': False, 18:14:31 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 18:14:31 INFO - 'linux64': {'bouncer-platform': 'linux64', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 18:14:31 INFO - 'macosx64': {'bouncer-platform': 'osx', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 18:14:31 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.tar.bz2'}, 18:14:31 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.tar.bz2'}, 18:14:31 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.tar.bz2'}, 18:14:31 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.tar.bz2'}, 18:14:31 INFO - 'win32': {'bouncer-platform': 'win', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 18:14:31 INFO - 'win64': {'bouncer-platform': 'win64', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 18:14:31 INFO - 'product-name': 'Firefox-%(version)s-SSL', 18:14:31 INFO - 'ssl-only': True}, 18:14:31 INFO - 'stub-installer': {'add-locales': False, 18:14:31 INFO - 'alias': 'firefox-stub', 18:14:31 INFO - 'paths': {'win32': {'bouncer-platform': 'win', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}, 18:14:31 INFO - 'win64': {'bouncer-platform': 'win64', 18:14:31 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}}, 18:14:31 INFO - 'product-name': 'Firefox-%(version)s-stub', 18:14:31 INFO - 'ssl-only': True}}, 18:14:31 INFO - 'repo': 'projects/jamun', 18:14:31 INFO - 'revision': u'18e3a714b829bdfd785810c16cc8469fcbe23d20', 18:14:31 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales', 18:14:31 INFO - 'version': u'46.0', 18:14:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:14:31 INFO - 'work_dir': 'build'} 18:14:31 INFO - ##### 18:14:31 INFO - ##### Running clobber step. 18:14:31 INFO - ##### 18:14:31 INFO - Running main action method: clobber 18:14:31 INFO - rmtree: /builds/slave/rel-jamun_fx_bncr_sub-00000000/build 18:14:31 INFO - ##### 18:14:31 INFO - ##### Running download-shipped-locales step. 18:14:31 INFO - ##### 18:14:31 INFO - Running main action method: download_shipped_locales 18:14:31 INFO - No need to download shipped-locales 18:14:31 INFO - ##### 18:14:31 INFO - ##### Running submit step. 18:14:31 INFO - ##### 18:14:31 INFO - Running main action method: submit 18:14:31 INFO - Checking if Firefox-46.0-Complete already exists 18:14:31 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Complete', None), kwargs: {}, attempt #1 18:14:31 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-Complete 18:14:32 INFO - Server response 18:14:32 INFO - 18:14:32 INFO - Products found: 1 18:14:32 WARNING - Product Firefox-46.0-Complete already exists. Skipping... 18:14:32 INFO - Checking if Firefox-46.0build4-Complete already exists 18:14:32 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build4-Complete', None), kwargs: {}, attempt #1 18:14:32 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0build4-Complete 18:14:33 INFO - Server response 18:14:33 INFO - 18:14:33 INFO - Products found: 0 18:14:33 INFO - Adding complete-mar-candidates... 18:14:33 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0build4-Complete'}), kwargs: {}, attempt #1 18:14:33 INFO - POST data: product=Firefox-46.0build4-Complete 18:14:33 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/ 18:14:33 INFO - Server response 18:14:33 INFO - 18:14:33 INFO - Adding paths... 18:14:33 INFO - linux (linux): /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-46.0.complete.mar 18:14:33 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 18:14:33 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 18:14:33 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:34 INFO - Server response 18:14:34 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-46.0.complete.mar 18:14:34 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-46.0.complete.mar 18:14:34 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 18:14:34 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 18:14:34 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:35 INFO - Server response 18:14:35 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-46.0.complete.mar 18:14:35 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-46.0.complete.mar 18:14:35 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 18:14:35 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 18:14:35 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:35 INFO - Server response 18:14:35 INFO - /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-46.0.complete.mar 18:14:35 INFO - win32 (win): /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-46.0.complete.mar 18:14:35 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 18:14:35 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 18:14:35 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:36 INFO - Server response 18:14:36 INFO - /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-46.0.complete.mar 18:14:36 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-46.0.complete.mar 18:14:36 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 18:14:36 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 18:14:36 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:36 INFO - Server response 18:14:36 INFO - /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-46.0.complete.mar 18:14:36 INFO - Checking if Firefox-46.0 already exists 18:14:36 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0', None), kwargs: {}, attempt #1 18:14:36 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0 18:14:37 INFO - Server response 18:14:37 INFO - 18:14:37 INFO - Products found: 1 18:14:37 WARNING - Product Firefox-46.0 already exists. Skipping... 18:14:37 INFO - Checking if Firefox-46.0-SSL already exists 18:14:37 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-SSL', None), kwargs: {}, attempt #1 18:14:37 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-SSL 18:14:37 INFO - Server response 18:14:37 INFO - 18:14:37 INFO - Products found: 1 18:14:37 WARNING - Product Firefox-46.0-SSL already exists. Skipping... 18:14:37 INFO - Checking if Firefox-46.0-stub already exists 18:14:37 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-stub', None), kwargs: {}, attempt #1 18:14:37 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-stub 18:14:38 INFO - Server response 18:14:38 INFO - 18:14:38 INFO - Products found: 1 18:14:38 WARNING - Product Firefox-46.0-stub already exists. Skipping... 18:14:38 INFO - Checking if Firefox-46.0build4-Partial-44.0build3 already exists 18:14:38 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build4-Partial-44.0build3', None), kwargs: {}, attempt #1 18:14:38 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0build4-Partial-44.0build3 18:14:38 INFO - Server response 18:14:38 INFO - 18:14:38 INFO - Products found: 0 18:14:38 INFO - Adding partial updates for Firefox-46.0build4-Partial-44.0build3 18:14:38 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0build4-Partial-44.0build3'}), kwargs: {}, attempt #1 18:14:38 INFO - POST data: product=Firefox-46.0build4-Partial-44.0build3 18:14:38 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/ 18:14:39 INFO - Server response 18:14:39 INFO - 18:14:39 INFO - linux (linux): /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-44.0-46.0.partial.mar 18:14:39 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-44.0build3', 'os': 'linux'}), kwargs: {}, attempt #1 18:14:39 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build4-Partial-44.0build3&os=linux 18:14:39 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:39 INFO - Server response 18:14:39 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-44.0-46.0.partial.mar 18:14:39 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-44.0-46.0.partial.mar 18:14:39 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-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-44.0build3', 'os': 'linux64'}), kwargs: {}, attempt #1 18:14:39 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build4-Partial-44.0build3&os=linux64 18:14:39 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:40 INFO - Server response 18:14:40 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-44.0-46.0.partial.mar 18:14:40 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-44.0-46.0.partial.mar 18:14:40 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-44.0build3', 'os': 'osx'}), kwargs: {}, attempt #1 18:14:40 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build4-Partial-44.0build3&os=osx 18:14:40 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:41 INFO - Server response 18:14:41 INFO - /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-44.0-46.0.partial.mar 18:14:41 INFO - win32 (win): /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-44.0-46.0.partial.mar 18:14:41 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-44.0build3', 'os': 'win'}), kwargs: {}, attempt #1 18:14:41 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build4-Partial-44.0build3&os=win 18:14:41 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:41 INFO - Server response 18:14:41 INFO - /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-44.0-46.0.partial.mar 18:14:41 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-44.0-46.0.partial.mar 18:14:41 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-44.0build3', 'os': 'win64'}), kwargs: {}, attempt #1 18:14:41 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build4-Partial-44.0build3&os=win64 18:14:41 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:42 INFO - Server response 18:14:42 INFO - /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-44.0-46.0.partial.mar 18:14:42 INFO - Checking if Firefox-46.0build4-Partial-45.0build2 already exists 18:14:42 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build4-Partial-45.0build2', None), kwargs: {}, attempt #1 18:14:42 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0build4-Partial-45.0build2 18:14:42 INFO - Server response 18:14:42 INFO - 18:14:42 INFO - Products found: 0 18:14:42 INFO - Adding partial updates for Firefox-46.0build4-Partial-45.0build2 18:14:42 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0build4-Partial-45.0build2'}), kwargs: {}, attempt #1 18:14:42 INFO - POST data: product=Firefox-46.0build4-Partial-45.0build2 18:14:42 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/ 18:14:43 INFO - Server response 18:14:43 INFO - 18:14:43 INFO - linux (linux): /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-45.0-46.0.partial.mar 18:14:43 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-45.0build2', 'os': 'linux'}), kwargs: {}, attempt #1 18:14:43 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build4-Partial-45.0build2&os=linux 18:14:43 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:43 INFO - Server response 18:14:43 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-i686/:lang/firefox-45.0-46.0.partial.mar 18:14:43 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-45.0-46.0.partial.mar 18:14:43 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-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-45.0build2', 'os': 'linux64'}), kwargs: {}, attempt #1 18:14:43 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build4-Partial-45.0build2&os=linux64 18:14:43 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:44 INFO - Server response 18:14:44 INFO - /firefox/candidates/46.0-candidates/build4/update/linux-x86_64/:lang/firefox-45.0-46.0.partial.mar 18:14:44 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-45.0-46.0.partial.mar 18:14:44 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-45.0build2', 'os': 'osx'}), kwargs: {}, attempt #1 18:14:44 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build4-Partial-45.0build2&os=osx 18:14:44 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:45 INFO - Server response 18:14:45 INFO - /firefox/candidates/46.0-candidates/build4/update/mac/:lang/firefox-45.0-46.0.partial.mar 18:14:45 INFO - win32 (win): /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-45.0-46.0.partial.mar 18:14:45 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-45.0build2', 'os': 'win'}), kwargs: {}, attempt #1 18:14:45 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build4-Partial-45.0build2&os=win 18:14:45 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:45 INFO - Server response 18:14:45 INFO - /firefox/candidates/46.0-candidates/build4/update/win32/:lang/firefox-45.0-46.0.partial.mar 18:14:45 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-45.0-46.0.partial.mar 18:14:45 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build4-Partial-45.0build2', 'os': 'win64'}), kwargs: {}, attempt #1 18:14:45 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild4%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build4-Partial-45.0build2&os=win64 18:14:45 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 18:14:46 INFO - Server response 18:14:46 INFO - /firefox/candidates/46.0-candidates/build4/update/win64/:lang/firefox-45.0-46.0.partial.mar 18:14:46 INFO - Checking if Firefox-46.0-Partial-44.0 already exists 18:14:46 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Partial-44.0', None), kwargs: {}, attempt #1 18:14:46 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-Partial-44.0 18:14:46 INFO - Server response 18:14:46 INFO - 18:14:46 INFO - Products found: 1 18:14:46 WARNING - Product Firefox-46.0-Partial-44.0 already exists. Skipping... 18:14:46 INFO - Checking if Firefox-46.0-Partial-45.0 already exists 18:14:46 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Partial-45.0', None), kwargs: {}, attempt #1 18:14:46 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-Partial-45.0 18:14:47 INFO - Server response 18:14:47 INFO - 18:14:47 INFO - Products found: 1 18:14:47 WARNING - Product Firefox-46.0-Partial-45.0 already exists. Skipping... 18:14:47 INFO - Running post-run listener: copy_logs_to_upload_dir 18:14:47 INFO - Copying logs to upload dir... 18:14:47 INFO - mkdir: /builds/slave/rel-jamun_fx_bncr_sub-00000000/build/upload/logs 18:14:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=15.729054 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 15 secs) (at 2016-04-09 18:14:47.285316) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:47.287888) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-470.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-jamun_fx_bncr_sub-00000000/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.04 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:47.335365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:47.335682) ========= rm -f oauth.txt in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-470.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-jamun_fx_bncr_sub-00000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002602 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:14:47.382680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 18:14:47.382968) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 18:14:47.383250) ========= ========= Total master_lag: 1.35 =========