builder: release-mozilla-beta_devedition_bncr_sub slave: bld-linux64-spot-383 starttime: 1503037582.53 results: success (0) revision: 80312a6daa088138cc3d53b3944cd814759a623f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:22.529949) ========= master: http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:22.530359) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:22.530637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:22.597904) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:22.598163) ========= rm -rf scripts properties in dir /builds/slave/rel-m-beta_de_bncr_sub-0000000/. (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-383.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-beta_de_bncr_sub-0000000 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.003906 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:22.648099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 23:26:22.648407) ========= bash -c 'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-beta --rev 80312a6daa088138cc3d53b3944cd814759a623f --destination scripts --debug' in dir /builds/slave/rel-m-beta_de_bncr_sub-0000000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-beta --rev 80312a6daa088138cc3d53b3944cd814759a623f --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-383.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-beta_de_bncr_sub-0000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2017-08-17 23:26:22,705 truncating revision to first 12 chars 2017-08-17 23:26:22,705 Setting DEBUG logging. 2017-08-17 23:26:22,705 attempt 1/10 2017-08-17 23:26:22,705 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/80312a6daa08?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 23:26:24,188 unpacking tar archive at: mozilla-beta-80312a6daa08/testing/mozharness/ program finished with exit code 0 elapsedTime=1.865899 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 23:26:24.522664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:24.523000) ========= script_repo_revision: 80312a6daa088138cc3d53b3944cd814759a623f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:24.523361) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:24.523629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:24.529398) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 4 secs) (at 2017-08-17 23:26:24.529667) ========= /tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_devedition.py --credentials-file oauth.txt --bouncer-api-prefix https://bounceradmin.mozilla.com/api --repo releases/mozilla-beta in dir /builds/slave/rel-m-beta_de_bncr_sub-0000000/. (timeout 3600 secs) (maxTime 14400 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/bouncer_submitter.py', '-c', 'releases/bouncer_firefox_devedition.py', '--credentials-file', 'oauth.txt', '--bouncer-api-prefix', 'https://bounceradmin.mozilla.com/api', '--repo', 'releases/mozilla-beta'] 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-383.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-beta_de_bncr_sub-0000000/buildprops.json PWD=/builds/slave/rel-m-beta_de_bncr_sub-0000000 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:26:24 INFO - MultiFileLogger online at 20170817 23:26:24 in /builds/slave/rel-m-beta_de_bncr_sub-0000000 23:26:24 INFO - Using buildbot properties: 23:26:24 INFO - { 23:26:24 INFO - "project": "", 23:26:24 INFO - "product": "devedition", 23:26:24 INFO - "build_number": 2, 23:26:24 INFO - "taskId": "qHPuG9fzRTqWpB3rSGkzhA", 23:26:24 INFO - "repository": "", 23:26:24 INFO - "buildername": "release-mozilla-beta_devedition_bncr_sub", 23:26:24 INFO - "basedir": "/builds/slave/rel-m-beta_de_bncr_sub-0000000", 23:26:24 INFO - "buildnumber": 1, 23:26:24 INFO - "slavename": "bld-linux64-spot-383", 23:26:24 INFO - "version": "56.0b4", 23:26:24 INFO - "release_promotion": true, 23:26:24 INFO - "platform": null, 23:26:24 INFO - "branch": "mozilla-beta", 23:26:24 INFO - "script_repo_revision": "80312a6daa088138cc3d53b3944cd814759a623f", 23:26:24 INFO - "master": "http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/", 23:26:24 INFO - "revision": "80312a6daa088138cc3d53b3944cd814759a623f", 23:26:24 INFO - "partial_versions": "56.0b1build5, 56.0b2build1, 56.0b3build1", 23:26:24 INFO - "repo_path": "releases/mozilla-beta" 23:26:24 INFO - } 23:26:24 INFO - Overriding product with devedition 23:26:24 INFO - Overriding version with 56.0b4 23:26:24 INFO - Overriding build_number with 2 23:26:24 INFO - Overriding revision with 80312a6daa088138cc3d53b3944cd814759a623f 23:26:24 INFO - Run as scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_devedition.py --credentials-file oauth.txt --bouncer-api-prefix https://bounceradmin.mozilla.com/api --repo releases/mozilla-beta 23:26:24 INFO - Dumping config to /builds/slave/rel-m-beta_de_bncr_sub-0000000/logs/localconfig.json. 23:26:24 INFO - {'append_to_log': False, 23:26:24 INFO - 'base_work_dir': '/builds/slave/rel-m-beta_de_bncr_sub-0000000', 23:26:24 INFO - 'bouncer-api-prefix': 'https://bounceradmin.mozilla.com/api', 23:26:24 INFO - 'build_number': 2, 23:26:24 INFO - 'buildbot_json_path': 'buildprops.json', 23:26:24 INFO - 'config_files': ('releases/bouncer_firefox_devedition.py',), 23:26:24 INFO - 'credentials_file': 'oauth.txt', 23:26:24 INFO - 'log_level': 'info', 23:26:24 INFO - 'log_to_console': True, 23:26:24 INFO - 'opt_config_files': (), 23:26:24 INFO - 'partials': {'releases-dir': {'add-locales': True, 23:26:24 INFO - 'check_uptake': True, 23:26:24 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 23:26:24 INFO - 'linux64': {'bouncer-platform': 'linux64', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 23:26:24 INFO - 'macosx64': {'bouncer-platform': 'osx', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 23:26:24 INFO - 'win32': {'bouncer-platform': 'win', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 23:26:24 INFO - 'win64': {'bouncer-platform': 'win64', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 23:26:24 INFO - 'product-name': 'Devedition-%(version)s-Partial-%(prev_version)s', 23:26:24 INFO - 'ssl-only': False}}, 23:26:24 INFO - 'prev_versions': (u'56.0b1build5', u'56.0b2build1', u'56.0b3build1'), 23:26:24 INFO - 'product': u'devedition', 23:26:24 INFO - 'products': {'complete-mar': {'add-locales': True, 23:26:24 INFO - 'check_uptake': True, 23:26:24 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 23:26:24 INFO - 'linux64': {'bouncer-platform': 'linux64', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 23:26:24 INFO - 'macosx64': {'bouncer-platform': 'osx', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 23:26:24 INFO - 'win32': {'bouncer-platform': 'win', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 23:26:24 INFO - 'win64': {'bouncer-platform': 'win64', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 23:26:24 INFO - 'product-name': 'Devedition-%(version)s-Complete', 23:26:24 INFO - 'ssl-only': False}, 23:26:24 INFO - 'installer': {'add-locales': True, 23:26:24 INFO - 'alias': 'firefox-devedition-latest', 23:26:24 INFO - 'check_uptake': True, 23:26:24 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 23:26:24 INFO - 'linux64': {'bouncer-platform': 'linux64', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 23:26:24 INFO - 'macosx64': {'bouncer-platform': 'osx', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 23:26:24 INFO - 'win32': {'bouncer-platform': 'win', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 23:26:24 INFO - 'win64': {'bouncer-platform': 'win64', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 23:26:24 INFO - 'product-name': 'Devedition-%(version)s', 23:26:24 INFO - 'ssl-only': False}, 23:26:24 INFO - 'installer-ssl': {'add-locales': True, 23:26:24 INFO - 'alias': 'firefox-devedition-latest-ssl', 23:26:24 INFO - 'check_uptake': True, 23:26:24 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 23:26:24 INFO - 'linux64': {'bouncer-platform': 'linux64', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 23:26:24 INFO - 'macosx64': {'bouncer-platform': 'osx', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 23:26:24 INFO - 'win32': {'bouncer-platform': 'win', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 23:26:24 INFO - 'win64': {'bouncer-platform': 'win64', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 23:26:24 INFO - 'product-name': 'Devedition-%(version)s-SSL', 23:26:24 INFO - 'ssl-only': True}, 23:26:24 INFO - 'stub-installer': {'add-locales': True, 23:26:24 INFO - 'alias': 'firefox-devedition-stub', 23:26:24 INFO - 'check_uptake': True, 23:26:24 INFO - 'paths': {'win32': {'bouncer-platform': 'win', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}, 23:26:24 INFO - 'win64': {'bouncer-platform': 'win64', 23:26:24 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}}, 23:26:24 INFO - 'product-name': 'Devedition-%(version)s-stub', 23:26:24 INFO - 'ssl-only': True}}, 23:26:24 INFO - 'repo': 'releases/mozilla-beta', 23:26:24 INFO - 'revision': u'80312a6daa088138cc3d53b3944cd814759a623f', 23:26:24 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales', 23:26:24 INFO - 'version': u'56.0b4', 23:26:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:26:24 INFO - 'work_dir': 'build'} 23:26:24 INFO - [mozharness: 2017-08-18 06:26:24.793345Z] Running clobber step. 23:26:24 INFO - Running main action method: clobber 23:26:24 INFO - rmtree: /builds/slave/rel-m-beta_de_bncr_sub-0000000/build 23:26:24 INFO - [mozharness: 2017-08-18 06:26:24.796328Z] Finished clobber step (success) 23:26:24 INFO - [mozharness: 2017-08-18 06:26:24.796660Z] Running download-shipped-locales step. 23:26:24 INFO - Running main action method: download_shipped_locales 23:26:24 INFO - mkdir: /builds/slave/rel-m-beta_de_bncr_sub-0000000/build 23:26:24 INFO - Downloading https://hg.mozilla.org/releases/mozilla-beta/raw-file/80312a6daa088138cc3d53b3944cd814759a623f/browser/locales/shipped-locales to /builds/slave/rel-m-beta_de_bncr_sub-0000000/build/shipped-locales 23:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://hg.mozilla.org/releases/mozilla-beta/raw-file/80312a6daa088138cc3d53b3944cd814759a623f/browser/locales/shipped-locales', 'file_name': '/builds/slave/rel-m-beta_de_bncr_sub-0000000/build/shipped-locales'}, attempt #1 23:26:25 INFO - Downloaded 386 bytes. 23:26:25 INFO - Reading from file /builds/slave/rel-m-beta_de_bncr_sub-0000000/build/shipped-locales 23:26:25 INFO - Contents: 23:26:25 INFO - ach 23:26:25 INFO - af 23:26:25 INFO - an 23:26:25 INFO - ar 23:26:25 INFO - as 23:26:25 INFO - ast 23:26:25 INFO - az 23:26:25 INFO - be 23:26:25 INFO - bg 23:26:25 INFO - bn-BD 23:26:25 INFO - bn-IN 23:26:25 INFO - br 23:26:25 INFO - bs 23:26:25 INFO - ca 23:26:25 INFO - cak 23:26:25 INFO - cs 23:26:25 INFO - cy 23:26:25 INFO - da 23:26:25 INFO - de 23:26:25 INFO - dsb 23:26:25 INFO - el 23:26:25 INFO - en-GB 23:26:25 INFO - en-US 23:26:25 INFO - en-ZA 23:26:25 INFO - eo 23:26:25 INFO - es-AR 23:26:25 INFO - es-CL 23:26:25 INFO - es-ES 23:26:25 INFO - es-MX 23:26:25 INFO - et 23:26:25 INFO - eu 23:26:25 INFO - fa 23:26:25 INFO - ff 23:26:25 INFO - fi 23:26:25 INFO - fr 23:26:25 INFO - fy-NL 23:26:25 INFO - ga-IE 23:26:25 INFO - gd 23:26:25 INFO - gl 23:26:25 INFO - gn 23:26:25 INFO - gu-IN 23:26:25 INFO - he 23:26:25 INFO - hi-IN 23:26:25 INFO - hr 23:26:25 INFO - hsb 23:26:25 INFO - hu 23:26:25 INFO - hy-AM 23:26:25 INFO - id 23:26:25 INFO - is 23:26:25 INFO - it 23:26:25 INFO - ja linux win32 23:26:25 INFO - ja-JP-mac osx 23:26:25 INFO - ka 23:26:25 INFO - kab 23:26:25 INFO - kk 23:26:25 INFO - km 23:26:25 INFO - kn 23:26:25 INFO - ko 23:26:25 INFO - lij 23:26:25 INFO - lt 23:26:25 INFO - lv 23:26:25 INFO - mai 23:26:25 INFO - mk 23:26:25 INFO - ml 23:26:25 INFO - mr 23:26:25 INFO - ms 23:26:25 INFO - my 23:26:25 INFO - nb-NO 23:26:25 INFO - nl 23:26:25 INFO - nn-NO 23:26:25 INFO - or 23:26:25 INFO - pa-IN 23:26:25 INFO - pl 23:26:25 INFO - pt-BR 23:26:25 INFO - pt-PT 23:26:25 INFO - rm 23:26:25 INFO - ro 23:26:25 INFO - ru 23:26:25 INFO - si 23:26:25 INFO - sk 23:26:25 INFO - sl 23:26:25 INFO - son 23:26:25 INFO - sq 23:26:25 INFO - sr 23:26:25 INFO - sv-SE 23:26:25 INFO - ta 23:26:25 INFO - te 23:26:25 INFO - th 23:26:25 INFO - tr 23:26:25 INFO - uk 23:26:25 INFO - ur 23:26:25 INFO - uz 23:26:25 INFO - vi 23:26:25 INFO - xh 23:26:25 INFO - zh-CN 23:26:25 INFO - zh-TW 23:26:25 INFO - [mozharness: 2017-08-18 06:26:25.712836Z] Finished download-shipped-locales step (success) 23:26:25 INFO - [mozharness: 2017-08-18 06:26:25.713019Z] Running submit step. 23:26:25 INFO - Running main action method: submit 23:26:25 INFO - Checking if Devedition-56.0b4-Complete already exists 23:26:25 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-56.0b4-Complete', None), kwargs: {}, attempt #1 23:26:25 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-56.0b4-Complete 23:26:26 INFO - Server response 23:26:26 INFO - 23:26:26 INFO - Products found: 1 23:26:26 WARNING - Product Devedition-56.0b4-Complete already exists. Skipping... 23:26:26 INFO - Checking if Devedition-56.0b4 already exists 23:26:26 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-56.0b4', None), kwargs: {}, attempt #1 23:26:26 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-56.0b4 23:26:26 INFO - Server response 23:26:26 INFO - 23:26:26 INFO - Products found: 1 23:26:26 WARNING - Product Devedition-56.0b4 already exists. Skipping... 23:26:26 INFO - Checking if Devedition-56.0b4-SSL already exists 23:26:26 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-56.0b4-SSL', None), kwargs: {}, attempt #1 23:26:26 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-56.0b4-SSL 23:26:27 INFO - Server response 23:26:27 INFO - 23:26:27 INFO - Products found: 1 23:26:27 WARNING - Product Devedition-56.0b4-SSL already exists. Skipping... 23:26:27 INFO - Checking if Devedition-56.0b4-stub already exists 23:26:27 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-56.0b4-stub', None), kwargs: {}, attempt #1 23:26:27 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-56.0b4-stub 23:26:27 INFO - Server response 23:26:27 INFO - 23:26:27 INFO - Products found: 1 23:26:27 WARNING - Product Devedition-56.0b4-stub already exists. Skipping... 23:26:27 INFO - Checking if Devedition-56.0b4-Partial-56.0b1 already exists 23:26:27 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-56.0b4-Partial-56.0b1', None), kwargs: {}, attempt #1 23:26:27 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-56.0b4-Partial-56.0b1 23:26:28 INFO - Server response 23:26:28 INFO - 23:26:28 INFO - Products found: 1 23:26:28 WARNING - Product Devedition-56.0b4-Partial-56.0b1 already exists. Skipping... 23:26:28 INFO - Checking if Devedition-56.0b4-Partial-56.0b2 already exists 23:26:28 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-56.0b4-Partial-56.0b2', None), kwargs: {}, attempt #1 23:26:28 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-56.0b4-Partial-56.0b2 23:26:29 INFO - Server response 23:26:29 INFO - 23:26:29 INFO - Products found: 1 23:26:29 WARNING - Product Devedition-56.0b4-Partial-56.0b2 already exists. Skipping... 23:26:29 INFO - Checking if Devedition-56.0b4-Partial-56.0b3 already exists 23:26:29 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-56.0b4-Partial-56.0b3', None), kwargs: {}, attempt #1 23:26:29 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-56.0b4-Partial-56.0b3 23:26:29 INFO - Server response 23:26:29 INFO - 23:26:29 INFO - Products found: 1 23:26:29 WARNING - Product Devedition-56.0b4-Partial-56.0b3 already exists. Skipping... 23:26:29 INFO - [mozharness: 2017-08-18 06:26:29.501914Z] Finished submit step (success) 23:26:29 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:29 INFO - Copying logs to upload dir... 23:26:29 INFO - mkdir: /builds/slave/rel-m-beta_de_bncr_sub-0000000/build/upload/logs 23:26:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=4.970336 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 4 secs) (at 2017-08-17 23:26:29.512975) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:29.514785) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-m-beta_de_bncr_sub-0000000/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-383.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-beta_de_bncr_sub-0000000/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.004961 ========= master_lag: 0.07 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:29.594497) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:29.594803) ========= rm -f oauth.txt in dir /builds/slave/rel-m-beta_de_bncr_sub-0000000/. (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-383.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-beta_de_bncr_sub-0000000 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.002650 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 23:26:29.641121) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 23:26:29.641401) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 23:26:29.641631) ========= ========= Total master_lag: 0.19 =========