builder: release-mozilla-beta_devedition_bncr_sub slave: bld-linux64-spot-029 starttime: 1510637433.6 results: success (0) revision: f7eb3bbcd5f830244a4234b1269c3a73e750330b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-11-13 21:30:33.603771) ========= master: http://buildbot-master77.bb.releng.use1.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-11-13 21:30:33.638834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-11-13 21:30:33.639271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-11-13 21:30:34.736313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2017-11-13 21:30:34.736906) ========= 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-029.build.releng.use1.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.003816 ========= master_lag: 2.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2017-11-13 21:30:36.902205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-11-13 21:30:36.902668) ========= bash -c 'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-beta --rev f7eb3bbcd5f830244a4234b1269c3a73e750330b --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 f7eb3bbcd5f830244a4234b1269c3a73e750330b --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-029.build.releng.use1.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-11-13 21:30:36,966 truncating revision to first 12 chars 2017-11-13 21:30:36,966 Setting DEBUG logging. 2017-11-13 21:30:36,967 attempt 1/10 2017-11-13 21:30:36,967 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f7eb3bbcd5f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-11-13 21:30:38,147 unpacking tar archive at: mozilla-beta-f7eb3bbcd5f8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.473067 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-11-13 21:30:39.405576) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-11-13 21:30:39.405912) ========= script_repo_revision: f7eb3bbcd5f830244a4234b1269c3a73e750330b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-11-13 21:30:39.406307) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-11-13 21:30:39.406579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-11-13 21:30:39.422866) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 6 secs) (at 2017-11-13 21:30:39.423274) ========= /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-029.build.releng.use1.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 21:30:39 INFO - MultiFileLogger online at 20171113 21:30:39 in /builds/slave/rel-m-beta_de_bncr_sub-0000000 21:30:39 INFO - Using buildbot properties: 21:30:39 INFO - { 21:30:39 INFO - "project": "", 21:30:39 INFO - "product": "devedition", 21:30:39 INFO - "build_number": 2, 21:30:39 INFO - "taskId": "fVKT3ok-QIef1uw82uIyRQ", 21:30:39 INFO - "repository": "", 21:30:39 INFO - "buildername": "release-mozilla-beta_devedition_bncr_sub", 21:30:39 INFO - "basedir": "/builds/slave/rel-m-beta_de_bncr_sub-0000000", 21:30:39 INFO - "buildnumber": 2, 21:30:39 INFO - "slavename": "bld-linux64-spot-029", 21:30:39 INFO - "version": "58.0b3", 21:30:39 INFO - "release_promotion": true, 21:30:39 INFO - "platform": null, 21:30:39 INFO - "branch": "mozilla-beta", 21:30:39 INFO - "script_repo_revision": "f7eb3bbcd5f830244a4234b1269c3a73e750330b", 21:30:39 INFO - "master": "http://buildbot-master77.bb.releng.use1.mozilla.com:8001/", 21:30:39 INFO - "revision": "f7eb3bbcd5f830244a4234b1269c3a73e750330b", 21:30:39 INFO - "partial_versions": "57.0b13build1, 57.0b14build1, 58.0b1build1", 21:30:39 INFO - "repo_path": "releases/mozilla-beta" 21:30:39 INFO - } 21:30:39 INFO - Overriding product with devedition 21:30:39 INFO - Overriding version with 58.0b3 21:30:39 INFO - Overriding build_number with 2 21:30:39 INFO - Overriding revision with f7eb3bbcd5f830244a4234b1269c3a73e750330b 21:30:39 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 21:30:39 INFO - Dumping config to /builds/slave/rel-m-beta_de_bncr_sub-0000000/logs/localconfig.json. 21:30:39 INFO - {'append_to_log': False, 21:30:39 INFO - 'base_work_dir': '/builds/slave/rel-m-beta_de_bncr_sub-0000000', 21:30:39 INFO - 'bouncer-api-prefix': 'https://bounceradmin.mozilla.com/api', 21:30:39 INFO - 'build_number': 2, 21:30:39 INFO - 'buildbot_json_path': 'buildprops.json', 21:30:39 INFO - 'config_files': ('releases/bouncer_firefox_devedition.py',), 21:30:39 INFO - 'credentials_file': 'oauth.txt', 21:30:39 INFO - 'log_level': 'info', 21:30:39 INFO - 'log_to_console': True, 21:30:39 INFO - 'opt_config_files': (), 21:30:39 INFO - 'partials': {'releases-dir': {'add-locales': True, 21:30:39 INFO - 'check_uptake': True, 21:30:39 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 21:30:39 INFO - 'linux64': {'bouncer-platform': 'linux64', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 21:30:39 INFO - 'macosx64': {'bouncer-platform': 'osx', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 21:30:39 INFO - 'win32': {'bouncer-platform': 'win', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 21:30:39 INFO - 'win64': {'bouncer-platform': 'win64', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 21:30:39 INFO - 'product-name': 'Devedition-%(version)s-Partial-%(prev_version)s', 21:30:39 INFO - 'ssl-only': False}}, 21:30:39 INFO - 'prev_versions': (u'57.0b13build1', u'57.0b14build1', u'58.0b1build1'), 21:30:39 INFO - 'product': u'devedition', 21:30:39 INFO - 'products': {'complete-mar': {'add-locales': True, 21:30:39 INFO - 'check_uptake': True, 21:30:39 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 21:30:39 INFO - 'linux64': {'bouncer-platform': 'linux64', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 21:30:39 INFO - 'macosx64': {'bouncer-platform': 'osx', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 21:30:39 INFO - 'win32': {'bouncer-platform': 'win', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 21:30:39 INFO - 'win64': {'bouncer-platform': 'win64', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 21:30:39 INFO - 'product-name': 'Devedition-%(version)s-Complete', 21:30:39 INFO - 'ssl-only': False}, 21:30:39 INFO - 'installer': {'add-locales': True, 21:30:39 INFO - 'alias': 'firefox-devedition-latest', 21:30:39 INFO - 'check_uptake': True, 21:30:39 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 21:30:39 INFO - 'linux64': {'bouncer-platform': 'linux64', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 21:30:39 INFO - 'macosx64': {'bouncer-platform': 'osx', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 21:30:39 INFO - 'win32': {'bouncer-platform': 'win', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 21:30:39 INFO - 'win64': {'bouncer-platform': 'win64', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 21:30:39 INFO - 'product-name': 'Devedition-%(version)s', 21:30:39 INFO - 'ssl-only': False}, 21:30:39 INFO - 'installer-ssl': {'add-locales': True, 21:30:39 INFO - 'alias': 'firefox-devedition-latest-ssl', 21:30:39 INFO - 'check_uptake': True, 21:30:39 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 21:30:39 INFO - 'linux64': {'bouncer-platform': 'linux64', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 21:30:39 INFO - 'macosx64': {'bouncer-platform': 'osx', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 21:30:39 INFO - 'win32': {'bouncer-platform': 'win', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 21:30:39 INFO - 'win64': {'bouncer-platform': 'win64', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 21:30:39 INFO - 'product-name': 'Devedition-%(version)s-SSL', 21:30:39 INFO - 'ssl-only': True}, 21:30:39 INFO - 'stub-installer': {'add-locales': True, 21:30:39 INFO - 'alias': 'firefox-devedition-stub', 21:30:39 INFO - 'check_uptake': True, 21:30:39 INFO - 'paths': {'win32': {'bouncer-platform': 'win', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}, 21:30:39 INFO - 'win64': {'bouncer-platform': 'win64', 21:30:39 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}}, 21:30:39 INFO - 'product-name': 'Devedition-%(version)s-stub', 21:30:39 INFO - 'ssl-only': True}}, 21:30:39 INFO - 'repo': 'releases/mozilla-beta', 21:30:39 INFO - 'revision': u'f7eb3bbcd5f830244a4234b1269c3a73e750330b', 21:30:39 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales', 21:30:39 INFO - 'version': u'58.0b3', 21:30:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:30:39 INFO - 'work_dir': 'build'} 21:30:39 INFO - [mozharness: 2017-11-14 05:30:39.847124Z] Running clobber step. 21:30:39 INFO - Running main action method: clobber 21:30:39 INFO - rmtree: /builds/slave/rel-m-beta_de_bncr_sub-0000000/build 21:30:39 INFO - [mozharness: 2017-11-14 05:30:39.850093Z] Finished clobber step (success) 21:30:39 INFO - [mozharness: 2017-11-14 05:30:39.850404Z] Running download-shipped-locales step. 21:30:39 INFO - Running main action method: download_shipped_locales 21:30:39 INFO - mkdir: /builds/slave/rel-m-beta_de_bncr_sub-0000000/build 21:30:39 INFO - Downloading https://hg.mozilla.org/releases/mozilla-beta/raw-file/f7eb3bbcd5f830244a4234b1269c3a73e750330b/browser/locales/shipped-locales to /builds/slave/rel-m-beta_de_bncr_sub-0000000/build/shipped-locales 21:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://hg.mozilla.org/releases/mozilla-beta/raw-file/f7eb3bbcd5f830244a4234b1269c3a73e750330b/browser/locales/shipped-locales', 'file_name': '/builds/slave/rel-m-beta_de_bncr_sub-0000000/build/shipped-locales'}, attempt #1 21:30:41 INFO - Downloaded 392 bytes. 21:30:41 INFO - Reading from file /builds/slave/rel-m-beta_de_bncr_sub-0000000/build/shipped-locales 21:30:41 INFO - Contents: 21:30:41 INFO - ach 21:30:41 INFO - af 21:30:41 INFO - an 21:30:41 INFO - ar 21:30:41 INFO - as 21:30:41 INFO - ast 21:30:41 INFO - az 21:30:41 INFO - be 21:30:41 INFO - bg 21:30:41 INFO - bn-BD 21:30:41 INFO - bn-IN 21:30:41 INFO - br 21:30:41 INFO - bs 21:30:41 INFO - ca 21:30:41 INFO - cak 21:30:41 INFO - cs 21:30:41 INFO - cy 21:30:41 INFO - da 21:30:41 INFO - de 21:30:41 INFO - dsb 21:30:41 INFO - el 21:30:41 INFO - en-GB 21:30:41 INFO - en-US 21:30:41 INFO - en-ZA 21:30:41 INFO - eo 21:30:41 INFO - es-AR 21:30:41 INFO - es-CL 21:30:41 INFO - es-ES 21:30:41 INFO - es-MX 21:30:41 INFO - et 21:30:41 INFO - eu 21:30:41 INFO - fa 21:30:41 INFO - ff 21:30:41 INFO - fi 21:30:41 INFO - fr 21:30:41 INFO - fy-NL 21:30:41 INFO - ga-IE 21:30:41 INFO - gd 21:30:41 INFO - gl 21:30:41 INFO - gn 21:30:41 INFO - gu-IN 21:30:41 INFO - he 21:30:41 INFO - hi-IN 21:30:41 INFO - hr 21:30:41 INFO - hsb 21:30:41 INFO - hu 21:30:41 INFO - hy-AM 21:30:41 INFO - id 21:30:41 INFO - is 21:30:41 INFO - it 21:30:41 INFO - ja linux win32 21:30:41 INFO - ja-JP-mac osx 21:30:41 INFO - ka 21:30:41 INFO - kab 21:30:41 INFO - kk 21:30:41 INFO - km 21:30:41 INFO - kn 21:30:41 INFO - ko 21:30:41 INFO - lij 21:30:41 INFO - lt 21:30:41 INFO - lv 21:30:41 INFO - mai 21:30:41 INFO - mk 21:30:41 INFO - ml 21:30:41 INFO - mr 21:30:41 INFO - ms 21:30:41 INFO - my 21:30:41 INFO - nb-NO 21:30:41 INFO - ne-NP 21:30:41 INFO - nl 21:30:41 INFO - nn-NO 21:30:41 INFO - or 21:30:41 INFO - pa-IN 21:30:41 INFO - pl 21:30:41 INFO - pt-BR 21:30:41 INFO - pt-PT 21:30:41 INFO - rm 21:30:41 INFO - ro 21:30:41 INFO - ru 21:30:41 INFO - si 21:30:41 INFO - sk 21:30:41 INFO - sl 21:30:41 INFO - son 21:30:41 INFO - sq 21:30:41 INFO - sr 21:30:41 INFO - sv-SE 21:30:41 INFO - ta 21:30:41 INFO - te 21:30:41 INFO - th 21:30:41 INFO - tr 21:30:41 INFO - uk 21:30:41 INFO - ur 21:30:41 INFO - uz 21:30:41 INFO - vi 21:30:41 INFO - xh 21:30:41 INFO - zh-CN 21:30:41 INFO - zh-TW 21:30:41 INFO - [mozharness: 2017-11-14 05:30:41.230118Z] Finished download-shipped-locales step (success) 21:30:41 INFO - [mozharness: 2017-11-14 05:30:41.230325Z] Running submit step. 21:30:41 INFO - Running main action method: submit 21:30:41 INFO - Checking if Devedition-58.0b3-Complete already exists 21:30:41 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-58.0b3-Complete', None), kwargs: {}, attempt #1 21:30:41 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-58.0b3-Complete 21:30:41 INFO - Server response 21:30:41 INFO - 21:30:41 INFO - Products found: 1 21:30:41 WARNING - Product Devedition-58.0b3-Complete already exists. Skipping... 21:30:41 INFO - Checking if Devedition-58.0b3 already exists 21:30:41 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-58.0b3', None), kwargs: {}, attempt #1 21:30:41 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-58.0b3 21:30:42 INFO - Server response 21:30:42 INFO - 21:30:42 INFO - Products found: 1 21:30:42 WARNING - Product Devedition-58.0b3 already exists. Skipping... 21:30:42 INFO - Checking if Devedition-58.0b3-SSL already exists 21:30:42 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-58.0b3-SSL', None), kwargs: {}, attempt #1 21:30:42 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-58.0b3-SSL 21:30:43 INFO - Server response 21:30:43 INFO - 21:30:43 INFO - Products found: 1 21:30:43 WARNING - Product Devedition-58.0b3-SSL already exists. Skipping... 21:30:43 INFO - Checking if Devedition-58.0b3-stub already exists 21:30:43 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-58.0b3-stub', None), kwargs: {}, attempt #1 21:30:43 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-58.0b3-stub 21:30:43 INFO - Server response 21:30:43 INFO - 21:30:43 INFO - Products found: 1 21:30:43 WARNING - Product Devedition-58.0b3-stub already exists. Skipping... 21:30:43 INFO - Checking if Devedition-58.0b3-Partial-57.0b13 already exists 21:30:43 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-58.0b3-Partial-57.0b13', None), kwargs: {}, attempt #1 21:30:43 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-58.0b3-Partial-57.0b13 21:30:44 INFO - Server response 21:30:44 INFO - 21:30:44 INFO - Products found: 1 21:30:44 WARNING - Product Devedition-58.0b3-Partial-57.0b13 already exists. Skipping... 21:30:44 INFO - Checking if Devedition-58.0b3-Partial-57.0b14 already exists 21:30:44 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-58.0b3-Partial-57.0b14', None), kwargs: {}, attempt #1 21:30:44 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-58.0b3-Partial-57.0b14 21:30:44 INFO - Server response 21:30:44 INFO - 21:30:44 INFO - Products found: 1 21:30:44 WARNING - Product Devedition-58.0b3-Partial-57.0b14 already exists. Skipping... 21:30:44 INFO - Checking if Devedition-58.0b3-Partial-58.0b1 already exists 21:30:44 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-58.0b3-Partial-58.0b1', None), kwargs: {}, attempt #1 21:30:44 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-58.0b3-Partial-58.0b1 21:30:45 INFO - Server response 21:30:45 INFO - 21:30:45 INFO - Products found: 1 21:30:45 WARNING - Product Devedition-58.0b3-Partial-58.0b1 already exists. Skipping... 21:30:45 INFO - [mozharness: 2017-11-14 05:30:45.515613Z] Finished submit step (success) 21:30:45 INFO - Running post-run listener: copy_logs_to_upload_dir 21:30:45 INFO - Copying logs to upload dir... 21:30:45 INFO - mkdir: /builds/slave/rel-m-beta_de_bncr_sub-0000000/build/upload/logs 21:30:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=6.074819 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 6 secs) (at 2017-11-13 21:30:45.556997) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2017-11-13 21:30:45.567800) ========= 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-029.build.releng.use1.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.004816 ========= master_lag: 0.06 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2017-11-13 21:30:45.636764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-11-13 21:30:45.637093) ========= 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-029.build.releng.use1.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.002462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-11-13 21:30:45.717348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-11-13 21:30:45.717662) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-11-13 21:30:45.717936) ========= ========= Total master_lag: 2.39 =========