builder: release-mozilla-beta_devedition_bncr_sub slave: bld-linux64-spot-302 starttime: 1515796841.5 results: success (0) revision: fbde5320505049a521f2e4f5d535eefb56c25ded ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2018-01-12 14:40:41.502977) ========= master: http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2018-01-12 14:40:41.518008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-01-12 14:40:41.518342) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-01-12 14:40:41.659546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-01-12 14:40:41.659880) ========= 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-302.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.004561 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-01-12 14:40:41.712506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 mins, 11 secs) (at 2018-01-12 14:40:41.712885) ========= bash -c 'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-beta --rev fbde5320505049a521f2e4f5d535eefb56c25ded --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 fbde5320505049a521f2e4f5d535eefb56c25ded --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-302.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 2018-01-12 14:40:41,762 truncating revision to first 12 chars 2018-01-12 14:40:41,762 Setting DEBUG logging. 2018-01-12 14:40:41,762 attempt 1/10 2018-01-12 14:40:41,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fbde53205050?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2018-01-12 14:40:42,842 attempt 1/10 2018-01-12 14:40:43,519 current task status: no status available at this point. state: PENDING 2018-01-12 14:40:43,519 sleeping for 10.00s (attempt 1/10) 2018-01-12 14:40:53,529 attempt 2/10 2018-01-12 14:40:54,181 current task status: no status available at this point. state: PENDING 2018-01-12 14:40:54,182 sleeping for 15.00s (attempt 2/10) 2018-01-12 14:41:09,197 attempt 3/10 2018-01-12 14:41:09,825 current task status: no status available at this point. state: PENDING 2018-01-12 14:41:09,825 sleeping for 21.50s (attempt 3/10) 2018-01-12 14:41:31,347 attempt 4/10 2018-01-12 14:41:31,977 current task status: no status available at this point. state: PENDING 2018-01-12 14:41:31,977 sleeping for 31.25s (attempt 4/10) 2018-01-12 14:42:03,259 attempt 5/10 2018-01-12 14:42:04,263 current task status: Task has expired from pending for too long. Re-creating task. state: RETRY 2018-01-12 14:42:04,263 sleeping for 47.88s (attempt 5/10) 2018-01-12 14:42:52,186 attempt 6/10 2018-01-12 14:42:52,714 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2018-01-12 14:42:52,782 unpacking tar archive at: mozilla-beta-fbde53205050/testing/mozharness/ program finished with exit code 0 elapsedTime=131.230828 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 mins, 11 secs) (at 2018-01-12 14:42:52.952841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-01-12 14:42:52.953179) ========= script_repo_revision: fbde5320505049a521f2e4f5d535eefb56c25ded ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-01-12 14:42:52.953569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-01-12 14:42:52.953874) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-01-12 14:42:52.960182) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 4 secs) (at 2018-01-12 14:42:52.960465) ========= /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-302.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 14:42:53 INFO - MultiFileLogger online at 20180112 14:42:53 in /builds/slave/rel-m-beta_de_bncr_sub-0000000 14:42:53 INFO - Using buildbot properties: 14:42:53 INFO - { 14:42:53 INFO - "project": "", 14:42:53 INFO - "product": "devedition", 14:42:53 INFO - "build_number": 5, 14:42:53 INFO - "taskId": "PL8OFgc8TwK5OQjxN-nrsA", 14:42:53 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 14:42:53 INFO - "buildername": "release-mozilla-beta_devedition_bncr_sub", 14:42:53 INFO - "balrog_api_root": "https://aus4-admin.mozilla.org/api", 14:42:53 INFO - "basedir": "/builds/slave/rel-m-beta_de_bncr_sub-0000000", 14:42:53 INFO - "appVersion": "59.0", 14:42:53 INFO - "buildnumber": 11, 14:42:53 INFO - "slavename": "bld-linux64-spot-302", 14:42:53 INFO - "version": "59.0b1", 14:42:53 INFO - "release_promotion": true, 14:42:53 INFO - "platform": null, 14:42:53 INFO - "branch": "mozilla-beta", 14:42:53 INFO - "script_repo_revision": "fbde5320505049a521f2e4f5d535eefb56c25ded", 14:42:53 INFO - "master": "http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/", 14:42:53 INFO - "revision": "fbde5320505049a521f2e4f5d535eefb56c25ded", 14:42:53 INFO - "partial_versions": "58.0b15build1, 58.0b14build2, 58.0b16build1", 14:42:53 INFO - "next_version": "59.0b2", 14:42:53 INFO - "repo_path": "releases/mozilla-beta" 14:42:53 INFO - } 14:42:53 INFO - Overriding product with devedition 14:42:53 INFO - Overriding version with 59.0b1 14:42:53 INFO - Overriding build_number with 5 14:42:53 INFO - Overriding revision with fbde5320505049a521f2e4f5d535eefb56c25ded 14:42:53 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 14:42:53 INFO - Dumping config to /builds/slave/rel-m-beta_de_bncr_sub-0000000/logs/localconfig.json. 14:42:53 INFO - {'append_to_log': False, 14:42:53 INFO - 'base_work_dir': '/builds/slave/rel-m-beta_de_bncr_sub-0000000', 14:42:53 INFO - 'bouncer-api-prefix': 'https://bounceradmin.mozilla.com/api', 14:42:53 INFO - 'build_number': 5, 14:42:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:42:53 INFO - 'config_files': ('releases/bouncer_firefox_devedition.py',), 14:42:53 INFO - 'credentials_file': 'oauth.txt', 14:42:53 INFO - 'log_level': 'info', 14:42:53 INFO - 'log_to_console': True, 14:42:53 INFO - 'opt_config_files': (), 14:42:53 INFO - 'partials': {'releases-dir': {'add-locales': True, 14:42:53 INFO - 'check_uptake': True, 14:42:53 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:42:53 INFO - 'linux64': {'bouncer-platform': 'linux64', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:42:53 INFO - 'macosx64': {'bouncer-platform': 'osx', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:42:53 INFO - 'win32': {'bouncer-platform': 'win', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 14:42:53 INFO - 'win64': {'bouncer-platform': 'win64', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 14:42:53 INFO - 'product-name': 'Devedition-%(version)s-Partial-%(prev_version)s', 14:42:53 INFO - 'ssl-only': False}}, 14:42:53 INFO - 'prev_versions': (u'58.0b15build1', u'58.0b14build2', u'58.0b16build1'), 14:42:53 INFO - 'product': u'devedition', 14:42:53 INFO - 'products': {'complete-mar': {'add-locales': True, 14:42:53 INFO - 'check_uptake': True, 14:42:53 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 14:42:53 INFO - 'linux64': {'bouncer-platform': 'linux64', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 14:42:53 INFO - 'macosx64': {'bouncer-platform': 'osx', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 14:42:53 INFO - 'win32': {'bouncer-platform': 'win', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 14:42:53 INFO - 'win64': {'bouncer-platform': 'win64', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 14:42:53 INFO - 'product-name': 'Devedition-%(version)s-Complete', 14:42:53 INFO - 'ssl-only': False}, 14:42:53 INFO - 'installer': {'add-locales': True, 14:42:53 INFO - 'alias': 'firefox-devedition-latest', 14:42:53 INFO - 'check_uptake': True, 14:42:53 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 14:42:53 INFO - 'linux64': {'bouncer-platform': 'linux64', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 14:42:53 INFO - 'macosx64': {'bouncer-platform': 'osx', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 14:42:53 INFO - 'win32': {'bouncer-platform': 'win', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 14:42:53 INFO - 'win64': {'bouncer-platform': 'win64', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 14:42:53 INFO - 'product-name': 'Devedition-%(version)s', 14:42:53 INFO - 'ssl-only': False}, 14:42:53 INFO - 'installer-ssl': {'add-locales': True, 14:42:53 INFO - 'alias': 'firefox-devedition-latest-ssl', 14:42:53 INFO - 'check_uptake': True, 14:42:53 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 14:42:53 INFO - 'linux64': {'bouncer-platform': 'linux64', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 14:42:53 INFO - 'macosx64': {'bouncer-platform': 'osx', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 14:42:53 INFO - 'win32': {'bouncer-platform': 'win', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 14:42:53 INFO - 'win64': {'bouncer-platform': 'win64', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 14:42:53 INFO - 'product-name': 'Devedition-%(version)s-SSL', 14:42:53 INFO - 'ssl-only': True}, 14:42:53 INFO - 'stub-installer': {'add-locales': True, 14:42:53 INFO - 'alias': 'firefox-devedition-stub', 14:42:53 INFO - 'check_uptake': True, 14:42:53 INFO - 'paths': {'win32': {'bouncer-platform': 'win', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}, 14:42:53 INFO - 'win64': {'bouncer-platform': 'win64', 14:42:53 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}}, 14:42:53 INFO - 'product-name': 'Devedition-%(version)s-stub', 14:42:53 INFO - 'ssl-only': True}}, 14:42:53 INFO - 'repo': 'releases/mozilla-beta', 14:42:53 INFO - 'revision': u'fbde5320505049a521f2e4f5d535eefb56c25ded', 14:42:53 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales', 14:42:53 INFO - 'version': u'59.0b1', 14:42:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:42:53 INFO - 'work_dir': 'build'} 14:42:53 INFO - [mozharness: 2018-01-12 22:42:53.484295Z] Running clobber step. 14:42:53 INFO - Running main action method: clobber 14:42:53 INFO - rmtree: /builds/slave/rel-m-beta_de_bncr_sub-0000000/build 14:42:53 INFO - [mozharness: 2018-01-12 22:42:53.487492Z] Finished clobber step (success) 14:42:53 INFO - [mozharness: 2018-01-12 22:42:53.487832Z] Running download-shipped-locales step. 14:42:53 INFO - Running main action method: download_shipped_locales 14:42:53 INFO - mkdir: /builds/slave/rel-m-beta_de_bncr_sub-0000000/build 14:42:53 INFO - Downloading https://hg.mozilla.org/releases/mozilla-beta/raw-file/fbde5320505049a521f2e4f5d535eefb56c25ded/browser/locales/shipped-locales to /builds/slave/rel-m-beta_de_bncr_sub-0000000/build/shipped-locales 14:42:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://hg.mozilla.org/releases/mozilla-beta/raw-file/fbde5320505049a521f2e4f5d535eefb56c25ded/browser/locales/shipped-locales', 'file_name': '/builds/slave/rel-m-beta_de_bncr_sub-0000000/build/shipped-locales'}, attempt #1 14:42:54 INFO - Downloaded 395 bytes. 14:42:54 INFO - Reading from file /builds/slave/rel-m-beta_de_bncr_sub-0000000/build/shipped-locales 14:42:54 INFO - Contents: 14:42:54 INFO - ach 14:42:54 INFO - af 14:42:54 INFO - an 14:42:54 INFO - ar 14:42:54 INFO - as 14:42:54 INFO - ast 14:42:54 INFO - az 14:42:54 INFO - be 14:42:54 INFO - bg 14:42:54 INFO - bn-BD 14:42:54 INFO - bn-IN 14:42:54 INFO - br 14:42:54 INFO - bs 14:42:54 INFO - ca 14:42:54 INFO - cak 14:42:54 INFO - cs 14:42:54 INFO - cy 14:42:54 INFO - da 14:42:54 INFO - de 14:42:54 INFO - dsb 14:42:54 INFO - el 14:42:54 INFO - en-GB 14:42:54 INFO - en-US 14:42:54 INFO - en-ZA 14:42:54 INFO - eo 14:42:54 INFO - es-AR 14:42:54 INFO - es-CL 14:42:54 INFO - es-ES 14:42:54 INFO - es-MX 14:42:54 INFO - et 14:42:54 INFO - eu 14:42:54 INFO - fa 14:42:54 INFO - ff 14:42:54 INFO - fi 14:42:54 INFO - fr 14:42:54 INFO - fy-NL 14:42:54 INFO - ga-IE 14:42:54 INFO - gd 14:42:54 INFO - gl 14:42:54 INFO - gn 14:42:54 INFO - gu-IN 14:42:54 INFO - he 14:42:54 INFO - hi-IN 14:42:54 INFO - hr 14:42:54 INFO - hsb 14:42:54 INFO - hu 14:42:54 INFO - hy-AM 14:42:54 INFO - ia 14:42:54 INFO - id 14:42:54 INFO - is 14:42:54 INFO - it 14:42:54 INFO - ja linux win32 14:42:54 INFO - ja-JP-mac osx 14:42:54 INFO - ka 14:42:54 INFO - kab 14:42:54 INFO - kk 14:42:54 INFO - km 14:42:54 INFO - kn 14:42:54 INFO - ko 14:42:54 INFO - lij 14:42:54 INFO - lt 14:42:54 INFO - lv 14:42:54 INFO - mai 14:42:54 INFO - mk 14:42:54 INFO - ml 14:42:54 INFO - mr 14:42:54 INFO - ms 14:42:54 INFO - my 14:42:54 INFO - nb-NO 14:42:54 INFO - ne-NP 14:42:54 INFO - nl 14:42:54 INFO - nn-NO 14:42:54 INFO - or 14:42:54 INFO - pa-IN 14:42:54 INFO - pl 14:42:54 INFO - pt-BR 14:42:54 INFO - pt-PT 14:42:54 INFO - rm 14:42:54 INFO - ro 14:42:54 INFO - ru 14:42:54 INFO - si 14:42:54 INFO - sk 14:42:54 INFO - sl 14:42:54 INFO - son 14:42:54 INFO - sq 14:42:54 INFO - sr 14:42:54 INFO - sv-SE 14:42:54 INFO - ta 14:42:54 INFO - te 14:42:54 INFO - th 14:42:54 INFO - tr 14:42:54 INFO - uk 14:42:54 INFO - ur 14:42:54 INFO - uz 14:42:54 INFO - vi 14:42:54 INFO - xh 14:42:54 INFO - zh-CN 14:42:54 INFO - zh-TW 14:42:54 INFO - [mozharness: 2018-01-12 22:42:54.666354Z] Finished download-shipped-locales step (success) 14:42:54 INFO - [mozharness: 2018-01-12 22:42:54.666578Z] Running submit step. 14:42:54 INFO - Running main action method: submit 14:42:54 INFO - Checking if Devedition-59.0b1-Complete already exists 14:42:54 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b1-Complete', None), kwargs: {}, attempt #1 14:42:54 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-59.0b1-Complete 14:42:55 INFO - Server response 14:42:55 INFO - 14:42:55 INFO - Products found: 1 14:42:55 WARNING - Product Devedition-59.0b1-Complete already exists. Skipping... 14:42:55 INFO - Checking if Devedition-59.0b1 already exists 14:42:55 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b1', None), kwargs: {}, attempt #1 14:42:55 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-59.0b1 14:42:55 INFO - Server response 14:42:55 INFO - 14:42:55 INFO - Products found: 1 14:42:55 WARNING - Product Devedition-59.0b1 already exists. Skipping... 14:42:55 INFO - Checking if Devedition-59.0b1-SSL already exists 14:42:55 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b1-SSL', None), kwargs: {}, attempt #1 14:42:55 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-59.0b1-SSL 14:42:55 INFO - Server response 14:42:55 INFO - 14:42:55 INFO - Products found: 1 14:42:55 WARNING - Product Devedition-59.0b1-SSL already exists. Skipping... 14:42:55 INFO - Checking if Devedition-59.0b1-stub already exists 14:42:55 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b1-stub', None), kwargs: {}, attempt #1 14:42:55 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-59.0b1-stub 14:42:56 INFO - Server response 14:42:56 INFO - 14:42:56 INFO - Products found: 1 14:42:56 WARNING - Product Devedition-59.0b1-stub already exists. Skipping... 14:42:56 INFO - Checking if Devedition-59.0b1-Partial-58.0b15 already exists 14:42:56 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b1-Partial-58.0b15', None), kwargs: {}, attempt #1 14:42:56 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-59.0b1-Partial-58.0b15 14:42:56 INFO - Server response 14:42:56 INFO - 14:42:56 INFO - Products found: 1 14:42:56 WARNING - Product Devedition-59.0b1-Partial-58.0b15 already exists. Skipping... 14:42:56 INFO - Checking if Devedition-59.0b1-Partial-58.0b14 already exists 14:42:56 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b1-Partial-58.0b14', None), kwargs: {}, attempt #1 14:42:56 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-59.0b1-Partial-58.0b14 14:42:57 INFO - Server response 14:42:57 INFO - 14:42:57 INFO - Products found: 1 14:42:57 WARNING - Product Devedition-59.0b1-Partial-58.0b14 already exists. Skipping... 14:42:57 INFO - Checking if Devedition-59.0b1-Partial-58.0b16 already exists 14:42:57 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b1-Partial-58.0b16', None), kwargs: {}, attempt #1 14:42:57 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Devedition-59.0b1-Partial-58.0b16 14:42:57 INFO - Server response 14:42:57 INFO - 14:42:57 INFO - Products found: 1 14:42:57 WARNING - Product Devedition-59.0b1-Partial-58.0b16 already exists. Skipping... 14:42:57 INFO - [mozharness: 2018-01-12 22:42:57.762047Z] Finished submit step (success) 14:42:57 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:57 INFO - Copying logs to upload dir... 14:42:57 INFO - mkdir: /builds/slave/rel-m-beta_de_bncr_sub-0000000/build/upload/logs 14:42:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=4.810910 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 4 secs) (at 2018-01-12 14:42:57.785925) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2018-01-12 14:42:57.787664) ========= 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-302.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.005283 ========= master_lag: 0.07 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2018-01-12 14:42:57.866836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-01-12 14:42:57.867146) ========= 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-302.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.003497 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-01-12 14:42:57.914266) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2018-01-12 14:42:57.914559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2018-01-12 14:42:57.914817) ========= ========= Total master_lag: 0.19 =========