builder: release-jamun_firefox_bncr_sub slave: bld-linux64-spot-533 starttime: 1460268068.87 results: success (0) revision: 18e3a714b829bdfd785810c16cc8469fcbe23d20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:08.872179) ========= master: http://buildbot-master74.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:08.872576) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:08.872864) ========= 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-533.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.004055 basedir: '/builds/slave/rel-jamun_fx_bncr_sub-00000000' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:08.927405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:08.927673) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:08.939203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:08.939466) ========= 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-533.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.002563 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:08.985353) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:08.985617) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:08.985927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:08.986230) ========= 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-533.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 23:01:08-- 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% 96.5M=0s 2016-04-09 23:01:09 (96.5 MB/s) - ‘archiver_client.py’ saved [12141/12141] program finished with exit code 0 elapsedTime=0.208821 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:09.205658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:09.205952) ========= 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-533.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.002516 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:09.252390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:09.252704) ========= 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-533.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 23:01:09,294 truncating revision to first 12 chars 2016-04-09 23:01:09,294 Setting DEBUG logging. 2016-04-09 23:01:09,294 attempt 1/10 2016-04-09 23:01:09,294 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 23:01:09,551 unpacking tar archive at: jamun-18e3a714b829/testing/mozharness/ program finished with exit code 0 elapsedTime=0.413450 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:09.677275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:09.677601) ========= 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-533.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.003618 script_repo_revision: '18e3a714b829bdfd785810c16cc8469fcbe23d20' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:09.725111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:09.725425) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:09.734098) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 15 secs) (at 2016-04-09 23:01:09.734381) ========= /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-533.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 23:01:09 INFO - MultiFileLogger online at 20160409 23:01:09 in /builds/slave/rel-jamun_fx_bncr_sub-00000000 23:01:09 INFO - Using buildbot properties: 23:01:09 INFO - { 23:01:09 INFO - "project": "", 23:01:09 INFO - "product": "firefox", 23:01:09 INFO - "build_number": 5, 23:01:09 INFO - "taskId": "RFUaFn9vTBOkDlMvQwlR9w", 23:01:09 INFO - "repository": "", 23:01:09 INFO - "buildername": "release-jamun_firefox_bncr_sub", 23:01:09 INFO - "basedir": "/builds/slave/rel-jamun_fx_bncr_sub-00000000", 23:01:09 INFO - "buildnumber": 1, 23:01:09 INFO - "slavename": "bld-linux64-spot-533", 23:01:09 INFO - "version": "46.0", 23:01:09 INFO - "release_promotion": true, 23:01:09 INFO - "platform": null, 23:01:09 INFO - "branch": "jamun", 23:01:09 INFO - "script_repo_revision": "18e3a714b829bdfd785810c16cc8469fcbe23d20", 23:01:09 INFO - "master": "http://buildbot-master74.bb.releng.usw2.mozilla.com:8001/", 23:01:09 INFO - "revision": "18e3a714b829bdfd785810c16cc8469fcbe23d20", 23:01:09 INFO - "partial_versions": "44.0build3, 45.0build2", 23:01:09 INFO - "repo_path": "projects/jamun" 23:01:09 INFO - } 23:01:09 INFO - Overriding product with firefox 23:01:09 INFO - Overriding version with 46.0 23:01:09 INFO - Overriding build_number with 5 23:01:09 INFO - Overriding revision with 18e3a714b829bdfd785810c16cc8469fcbe23d20 23:01:09 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 23:01:09 INFO - Dumping config to /builds/slave/rel-jamun_fx_bncr_sub-00000000/logs/localconfig.json. 23:01:09 INFO - {'append_to_log': False, 23:01:09 INFO - 'base_work_dir': '/builds/slave/rel-jamun_fx_bncr_sub-00000000', 23:01:09 INFO - 'bouncer-api-prefix': 'https://admin-bouncer.stage.mozaws.net/api', 23:01:09 INFO - 'build_number': 5, 23:01:09 INFO - 'buildbot_json_path': 'buildprops.json', 23:01:09 INFO - 'config_files': ('releases/bouncer_firefox_release.py',), 23:01:09 INFO - 'credentials_file': 'oauth.txt', 23:01:09 INFO - 'log_level': 'info', 23:01:09 INFO - 'log_to_console': True, 23:01:09 INFO - 'opt_config_files': (), 23:01:09 INFO - 'partials': {'candidates-dir': {'add-locales': False, 23:01:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 23:01:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 23:01:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 23:01: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'}, 23:01:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 23:01:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 23:01:09 INFO - 'win32': {'bouncer-platform': 'win', 23:01:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 23:01:09 INFO - 'win64': {'bouncer-platform': 'win64', 23:01:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 23:01:09 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Partial-%(prev_version)sbuild%(prev_build_number)s', 23:01:09 INFO - 'ssl-only': False}, 23:01:09 INFO - 'releases-dir': {'add-locales': False, 23:01:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 23:01:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 23:01:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 23:01:09 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.opensolaris-i386.partial.mar'}, 23:01:09 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.opensolaris-sparc.partial.mar'}, 23:01:09 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.solaris-i386.partial.mar'}, 23:01:09 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.solaris-sparc.partial.mar'}, 23:01:09 INFO - 'win32': {'bouncer-platform': 'win', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 23:01:09 INFO - 'win64': {'bouncer-platform': 'win64', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 23:01:09 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s', 23:01:09 INFO - 'ssl-only': False}}, 23:01:09 INFO - 'prev_versions': (u'44.0build3', u'45.0build2'), 23:01:09 INFO - 'product': u'firefox', 23:01:09 INFO - 'products': {'complete-mar': {'add-locales': False, 23:01:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 23:01:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 23:01:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 23:01:09 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.complete.mar'}, 23:01:09 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.complete.mar'}, 23:01:09 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.complete.mar'}, 23:01:09 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.complete.mar'}, 23:01:09 INFO - 'win32': {'bouncer-platform': 'win', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 23:01:09 INFO - 'win64': {'bouncer-platform': 'win64', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 23:01:09 INFO - 'product-name': 'Firefox-%(version)s-Complete', 23:01:09 INFO - 'ssl-only': False}, 23:01:09 INFO - 'complete-mar-candidates': {'add-locales': False, 23:01:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 23:01:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 23:01:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 23:01:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 23:01:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 23:01:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 23:01:09 INFO - 'win32': {'bouncer-platform': 'win', 23:01:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 23:01:09 INFO - 'win64': {'bouncer-platform': 'win64', 23:01:09 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 23:01:09 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete', 23:01:09 INFO - 'ssl-only': False}, 23:01:09 INFO - 'installer': {'add-locales': False, 23:01:09 INFO - 'alias': 'firefox-latest', 23:01:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 23:01:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 23:01:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 23:01:09 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.tar.bz2'}, 23:01:09 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.tar.bz2'}, 23:01:09 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.tar.bz2'}, 23:01:09 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.tar.bz2'}, 23:01:09 INFO - 'win32': {'bouncer-platform': 'win', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 23:01:09 INFO - 'win64': {'bouncer-platform': 'win64', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 23:01:09 INFO - 'product-name': 'Firefox-%(version)s', 23:01:09 INFO - 'ssl-only': False}, 23:01:09 INFO - 'installer-ssl': {'add-locales': False, 23:01:09 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 23:01:09 INFO - 'linux64': {'bouncer-platform': 'linux64', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 23:01:09 INFO - 'macosx64': {'bouncer-platform': 'osx', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 23:01:09 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.tar.bz2'}, 23:01:09 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.tar.bz2'}, 23:01:09 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.tar.bz2'}, 23:01:09 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.tar.bz2'}, 23:01:09 INFO - 'win32': {'bouncer-platform': 'win', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 23:01:09 INFO - 'win64': {'bouncer-platform': 'win64', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 23:01:09 INFO - 'product-name': 'Firefox-%(version)s-SSL', 23:01:09 INFO - 'ssl-only': True}, 23:01:09 INFO - 'stub-installer': {'add-locales': False, 23:01:09 INFO - 'alias': 'firefox-stub', 23:01:09 INFO - 'paths': {'win32': {'bouncer-platform': 'win', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}, 23:01:09 INFO - 'win64': {'bouncer-platform': 'win64', 23:01:09 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}}, 23:01:09 INFO - 'product-name': 'Firefox-%(version)s-stub', 23:01:09 INFO - 'ssl-only': True}}, 23:01:09 INFO - 'repo': 'projects/jamun', 23:01:09 INFO - 'revision': u'18e3a714b829bdfd785810c16cc8469fcbe23d20', 23:01:09 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales', 23:01:09 INFO - 'version': u'46.0', 23:01:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:01:09 INFO - 'work_dir': 'build'} 23:01:09 INFO - ##### 23:01:09 INFO - ##### Running clobber step. 23:01:09 INFO - ##### 23:01:09 INFO - Running main action method: clobber 23:01:09 INFO - rmtree: /builds/slave/rel-jamun_fx_bncr_sub-00000000/build 23:01:09 INFO - ##### 23:01:09 INFO - ##### Running download-shipped-locales step. 23:01:09 INFO - ##### 23:01:09 INFO - Running main action method: download_shipped_locales 23:01:09 INFO - No need to download shipped-locales 23:01:09 INFO - ##### 23:01:09 INFO - ##### Running submit step. 23:01:09 INFO - ##### 23:01:09 INFO - Running main action method: submit 23:01:09 INFO - Checking if Firefox-46.0-Complete already exists 23:01:09 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Complete', None), kwargs: {}, attempt #1 23:01:09 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-Complete 23:01:10 INFO - Server response 23:01:10 INFO - 23:01:10 INFO - Products found: 1 23:01:10 WARNING - Product Firefox-46.0-Complete already exists. Skipping... 23:01:10 INFO - Checking if Firefox-46.0build5-Complete already exists 23:01:10 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build5-Complete', None), kwargs: {}, attempt #1 23:01:10 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0build5-Complete 23:01:11 INFO - Server response 23:01:11 INFO - 23:01:11 INFO - Products found: 0 23:01:11 INFO - Adding complete-mar-candidates... 23:01:11 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0build5-Complete'}), kwargs: {}, attempt #1 23:01:11 INFO - POST data: product=Firefox-46.0build5-Complete 23:01:11 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/ 23:01:11 INFO - Server response 23:01:11 INFO - 23:01:11 INFO - Adding paths... 23:01:11 INFO - linux (linux): /firefox/candidates/46.0-candidates/build5/update/linux-i686/:lang/firefox-46.0.complete.mar 23:01:11 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/linux-i686/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build5-Complete', 'os': 'linux'}), kwargs: {}, attempt #1 23:01:11 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build5-Complete&os=linux 23:01:11 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:12 INFO - Server response 23:01:12 INFO - /firefox/candidates/46.0-candidates/build5/update/linux-i686/:lang/firefox-46.0.complete.mar 23:01:12 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build5/update/linux-x86_64/:lang/firefox-46.0.complete.mar 23:01:12 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/linux-x86_64/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build5-Complete', 'os': 'linux64'}), kwargs: {}, attempt #1 23:01:12 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build5-Complete&os=linux64 23:01:12 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:12 INFO - Server response 23:01:12 INFO - /firefox/candidates/46.0-candidates/build5/update/linux-x86_64/:lang/firefox-46.0.complete.mar 23:01:12 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build5/update/mac/:lang/firefox-46.0.complete.mar 23:01:12 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/mac/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build5-Complete', 'os': 'osx'}), kwargs: {}, attempt #1 23:01:12 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build5-Complete&os=osx 23:01:12 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:13 INFO - Server response 23:01:13 INFO - /firefox/candidates/46.0-candidates/build5/update/mac/:lang/firefox-46.0.complete.mar 23:01:13 INFO - win32 (win): /firefox/candidates/46.0-candidates/build5/update/win32/:lang/firefox-46.0.complete.mar 23:01:13 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/win32/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build5-Complete', 'os': 'win'}), kwargs: {}, attempt #1 23:01:13 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build5-Complete&os=win 23:01:13 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:14 INFO - Server response 23:01:14 INFO - /firefox/candidates/46.0-candidates/build5/update/win32/:lang/firefox-46.0.complete.mar 23:01:14 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build5/update/win64/:lang/firefox-46.0.complete.mar 23:01:14 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/win64/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build5-Complete', 'os': 'win64'}), kwargs: {}, attempt #1 23:01:14 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build5-Complete&os=win64 23:01:14 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:14 INFO - Server response 23:01:14 INFO - /firefox/candidates/46.0-candidates/build5/update/win64/:lang/firefox-46.0.complete.mar 23:01:14 INFO - Checking if Firefox-46.0 already exists 23:01:14 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0', None), kwargs: {}, attempt #1 23:01:14 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0 23:01:15 INFO - Server response 23:01:15 INFO - 23:01:15 INFO - Products found: 1 23:01:15 WARNING - Product Firefox-46.0 already exists. Skipping... 23:01:15 INFO - Checking if Firefox-46.0-SSL already exists 23:01:15 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-SSL', None), kwargs: {}, attempt #1 23:01:15 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-SSL 23:01:15 INFO - Server response 23:01:15 INFO - 23:01:15 INFO - Products found: 1 23:01:15 WARNING - Product Firefox-46.0-SSL already exists. Skipping... 23:01:15 INFO - Checking if Firefox-46.0-stub already exists 23:01:15 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-stub', None), kwargs: {}, attempt #1 23:01:15 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-stub 23:01:16 INFO - Server response 23:01:16 INFO - 23:01:16 INFO - Products found: 1 23:01:16 WARNING - Product Firefox-46.0-stub already exists. Skipping... 23:01:16 INFO - Checking if Firefox-46.0build5-Partial-44.0build3 already exists 23:01:16 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build5-Partial-44.0build3', None), kwargs: {}, attempt #1 23:01:16 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0build5-Partial-44.0build3 23:01:16 INFO - Server response 23:01:16 INFO - 23:01:16 INFO - Products found: 0 23:01:16 INFO - Adding partial updates for Firefox-46.0build5-Partial-44.0build3 23:01:16 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0build5-Partial-44.0build3'}), kwargs: {}, attempt #1 23:01:16 INFO - POST data: product=Firefox-46.0build5-Partial-44.0build3 23:01:16 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/ 23:01:17 INFO - Server response 23:01:17 INFO - 23:01:17 INFO - linux (linux): /firefox/candidates/46.0-candidates/build5/update/linux-i686/:lang/firefox-44.0-46.0.partial.mar 23:01:17 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/linux-i686/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build5-Partial-44.0build3', 'os': 'linux'}), kwargs: {}, attempt #1 23:01:17 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build5-Partial-44.0build3&os=linux 23:01:17 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:18 INFO - Server response 23:01:18 INFO - /firefox/candidates/46.0-candidates/build5/update/linux-i686/:lang/firefox-44.0-46.0.partial.mar 23:01:18 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build5/update/linux-x86_64/:lang/firefox-44.0-46.0.partial.mar 23:01:18 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/linux-x86_64/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build5-Partial-44.0build3', 'os': 'linux64'}), kwargs: {}, attempt #1 23:01:18 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build5-Partial-44.0build3&os=linux64 23:01:18 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:18 INFO - Server response 23:01:18 INFO - /firefox/candidates/46.0-candidates/build5/update/linux-x86_64/:lang/firefox-44.0-46.0.partial.mar 23:01:18 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build5/update/mac/:lang/firefox-44.0-46.0.partial.mar 23:01:18 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/mac/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build5-Partial-44.0build3', 'os': 'osx'}), kwargs: {}, attempt #1 23:01:18 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build5-Partial-44.0build3&os=osx 23:01:18 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:19 INFO - Server response 23:01:19 INFO - /firefox/candidates/46.0-candidates/build5/update/mac/:lang/firefox-44.0-46.0.partial.mar 23:01:19 INFO - win32 (win): /firefox/candidates/46.0-candidates/build5/update/win32/:lang/firefox-44.0-46.0.partial.mar 23:01:19 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/win32/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build5-Partial-44.0build3', 'os': 'win'}), kwargs: {}, attempt #1 23:01:19 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build5-Partial-44.0build3&os=win 23:01:19 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:19 INFO - Server response 23:01:19 INFO - /firefox/candidates/46.0-candidates/build5/update/win32/:lang/firefox-44.0-46.0.partial.mar 23:01:19 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build5/update/win64/:lang/firefox-44.0-46.0.partial.mar 23:01:19 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/win64/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build5-Partial-44.0build3', 'os': 'win64'}), kwargs: {}, attempt #1 23:01:19 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build5-Partial-44.0build3&os=win64 23:01:19 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:20 INFO - Server response 23:01:20 INFO - /firefox/candidates/46.0-candidates/build5/update/win64/:lang/firefox-44.0-46.0.partial.mar 23:01:20 INFO - Checking if Firefox-46.0build5-Partial-45.0build2 already exists 23:01:20 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build5-Partial-45.0build2', None), kwargs: {}, attempt #1 23:01:20 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0build5-Partial-45.0build2 23:01:20 INFO - Server response 23:01:20 INFO - 23:01:20 INFO - Products found: 0 23:01:20 INFO - Adding partial updates for Firefox-46.0build5-Partial-45.0build2 23:01:20 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0build5-Partial-45.0build2'}), kwargs: {}, attempt #1 23:01:20 INFO - POST data: product=Firefox-46.0build5-Partial-45.0build2 23:01:20 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/ 23:01:21 INFO - Server response 23:01:21 INFO - 23:01:21 INFO - linux (linux): /firefox/candidates/46.0-candidates/build5/update/linux-i686/:lang/firefox-45.0-46.0.partial.mar 23:01:21 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/linux-i686/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build5-Partial-45.0build2', 'os': 'linux'}), kwargs: {}, attempt #1 23:01:21 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build5-Partial-45.0build2&os=linux 23:01:21 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:22 INFO - Server response 23:01:22 INFO - /firefox/candidates/46.0-candidates/build5/update/linux-i686/:lang/firefox-45.0-46.0.partial.mar 23:01:22 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build5/update/linux-x86_64/:lang/firefox-45.0-46.0.partial.mar 23:01:22 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/linux-x86_64/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build5-Partial-45.0build2', 'os': 'linux64'}), kwargs: {}, attempt #1 23:01:22 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build5-Partial-45.0build2&os=linux64 23:01:22 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:22 INFO - Server response 23:01:22 INFO - /firefox/candidates/46.0-candidates/build5/update/linux-x86_64/:lang/firefox-45.0-46.0.partial.mar 23:01:22 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build5/update/mac/:lang/firefox-45.0-46.0.partial.mar 23:01:22 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/mac/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build5-Partial-45.0build2', 'os': 'osx'}), kwargs: {}, attempt #1 23:01:22 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build5-Partial-45.0build2&os=osx 23:01:22 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:23 INFO - Server response 23:01:23 INFO - /firefox/candidates/46.0-candidates/build5/update/mac/:lang/firefox-45.0-46.0.partial.mar 23:01:23 INFO - win32 (win): /firefox/candidates/46.0-candidates/build5/update/win32/:lang/firefox-45.0-46.0.partial.mar 23:01:23 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/win32/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build5-Partial-45.0build2', 'os': 'win'}), kwargs: {}, attempt #1 23:01:23 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build5-Partial-45.0build2&os=win 23:01:23 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:23 INFO - Server response 23:01:23 INFO - /firefox/candidates/46.0-candidates/build5/update/win32/:lang/firefox-45.0-46.0.partial.mar 23:01:23 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build5/update/win64/:lang/firefox-45.0-46.0.partial.mar 23:01:23 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build5/update/win64/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build5-Partial-45.0build2', 'os': 'win64'}), kwargs: {}, attempt #1 23:01:23 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild5%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build5-Partial-45.0build2&os=win64 23:01:23 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/ 23:01:24 INFO - Server response 23:01:24 INFO - /firefox/candidates/46.0-candidates/build5/update/win64/:lang/firefox-45.0-46.0.partial.mar 23:01:24 INFO - Checking if Firefox-46.0-Partial-44.0 already exists 23:01:24 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Partial-44.0', None), kwargs: {}, attempt #1 23:01:24 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-Partial-44.0 23:01:24 INFO - Server response 23:01:24 INFO - 23:01:24 INFO - Products found: 1 23:01:24 WARNING - Product Firefox-46.0-Partial-44.0 already exists. Skipping... 23:01:24 INFO - Checking if Firefox-46.0-Partial-45.0 already exists 23:01:24 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Partial-45.0', None), kwargs: {}, attempt #1 23:01:24 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-Partial-45.0 23:01:25 INFO - Server response 23:01:25 INFO - 23:01:25 INFO - Products found: 1 23:01:25 WARNING - Product Firefox-46.0-Partial-45.0 already exists. Skipping... 23:01:25 INFO - Running post-run listener: copy_logs_to_upload_dir 23:01:25 INFO - Copying logs to upload dir... 23:01:25 INFO - mkdir: /builds/slave/rel-jamun_fx_bncr_sub-00000000/build/upload/logs 23:01:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=15.710532 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 15 secs) (at 2016-04-09 23:01:25.460823) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:25.463469) ========= 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-533.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.004725 ========= master_lag: 0.04 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:25.510902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:25.511230) ========= 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-533.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.002527 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 23:01:25.557629) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 23:01:25.557930) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 23:01:25.558204) ========= ========= Total master_lag: 0.31 =========