builder: release-birch_firefox_bncr_sub slave: bld-linux64-spot-303 starttime: 1518548818.77 results: success (0) revision: 36ae5fede0a2d566494ad0be54f631bf2686faea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2018-02-13 11:06:58.774318) ========= master: http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2018-02-13 11:06:58.774758) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-02-13 11:06:58.775044) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-02-13 11:06:58.829401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-02-13 11:06:58.829693) ========= 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-bir_fx_bncr_sub-0000000000/. (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-303.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-bir_fx_bncr_sub-0000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False --2018-02-13 11:06:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: ‘archiver_client.py’ 0K .......... . 100% 505K=0.02s 2018-02-13 11:06:59 (505 KB/s) - ‘archiver_client.py’ saved [12179/12179] program finished with exit code 0 elapsedTime=0.250163 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-02-13 11:06:59.151660) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-02-13 11:06:59.151989) ========= rm -rf scripts properties in dir /builds/slave/rel-bir_fx_bncr_sub-0000000000/. (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-303.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-bir_fx_bncr_sub-0000000000 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.003043 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-02-13 11:06:59.227776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 mins, 16 secs) (at 2018-02-13 11:06:59.228158) ========= bash -c 'python archiver_client.py mozharness --repo projects/birch --rev 36ae5fede0a2d566494ad0be54f631bf2686faea --destination scripts --debug' in dir /builds/slave/rel-bir_fx_bncr_sub-0000000000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/birch --rev 36ae5fede0a2d566494ad0be54f631bf2686faea --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-303.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-bir_fx_bncr_sub-0000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2018-02-13 11:06:59,275 truncating revision to first 12 chars 2018-02-13 11:06:59,275 Setting DEBUG logging. 2018-02-13 11:06:59,275 attempt 1/10 2018-02-13 11:06:59,275 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/birch/36ae5fede0a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2018-02-13 11:06:59,950 attempt 1/10 2018-02-13 11:07:00,567 current task status: no status available at this point. state: PENDING 2018-02-13 11:07:00,567 sleeping for 11.00s (attempt 1/10) 2018-02-13 11:07:11,578 attempt 2/10 2018-02-13 11:07:12,187 current task status: no status available at this point. state: PENDING 2018-02-13 11:07:12,187 sleeping for 15.50s (attempt 2/10) 2018-02-13 11:07:27,697 attempt 3/10 2018-02-13 11:07:28,361 current task status: no status available at this point. state: PENDING 2018-02-13 11:07:28,361 sleeping for 23.25s (attempt 3/10) 2018-02-13 11:07:51,635 attempt 4/10 2018-02-13 11:07:52,248 current task status: no status available at this point. state: PENDING 2018-02-13 11:07:52,248 sleeping for 33.88s (attempt 4/10) 2018-02-13 11:08:26,157 attempt 5/10 2018-02-13 11:08:27,135 current task status: Task has expired from pending for too long. Re-creating task. state: RETRY 2018-02-13 11:08:27,135 sleeping for 50.81s (attempt 5/10) 2018-02-13 11:09:17,999 attempt 6/10 2018-02-13 11:09:18,657 current task status: no status available at this point. state: PENDING 2018-02-13 11:09:18,657 sleeping for 76.22s (attempt 6/10) 2018-02-13 11:10:34,952 attempt 7/10 2018-02-13 11:10:35,978 current task status: Task has expired from pending for too long. Re-creating task. state: RETRY 2018-02-13 11:10:35,978 sleeping for 99.00s (attempt 7/10) 2018-02-13 11:12:15,077 attempt 8/10 2018-02-13 11:12:15,602 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2018-02-13 11:12:15,730 unpacking tar archive at: birch-36ae5fede0a2/testing/mozharness/ program finished with exit code 0 elapsedTime=316.658413 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 mins, 16 secs) (at 2018-02-13 11:12:15.895950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-02-13 11:12:15.896290) ========= script_repo_revision: 36ae5fede0a2d566494ad0be54f631bf2686faea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-02-13 11:12:15.896690) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-02-13 11:12:15.896967) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-02-13 11:12:15.903317) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 17 secs) (at 2018-02-13 11:12:15.903591) ========= /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-releng.stage.mozaws.net/api --repo projects/birch in dir /builds/slave/rel-bir_fx_bncr_sub-0000000000/. (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-releng.stage.mozaws.net/api', '--repo', 'projects/birch'] 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-303.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-bir_fx_bncr_sub-0000000000/buildprops.json PWD=/builds/slave/rel-bir_fx_bncr_sub-0000000000 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 11:12:16 INFO - MultiFileLogger online at 20180213 11:12:16 in /builds/slave/rel-bir_fx_bncr_sub-0000000000 11:12:16 INFO - Using buildbot properties: 11:12:16 INFO - { 11:12:16 INFO - "project": "", 11:12:16 INFO - "product": "firefox", 11:12:16 INFO - "build_number": 6, 11:12:16 INFO - "taskId": "HWLHy-e6TjmHNhA5cq3tvA", 11:12:16 INFO - "repository": "https://hg.mozilla.org/projects/birch", 11:12:16 INFO - "buildername": "release-birch_firefox_bncr_sub", 11:12:16 INFO - "balrog_api_root": "https://balrog-admin.stage.mozaws.net/api", 11:12:16 INFO - "basedir": "/builds/slave/rel-bir_fx_bncr_sub-0000000000", 11:12:16 INFO - "appVersion": "61.0", 11:12:16 INFO - "buildnumber": 14, 11:12:16 INFO - "slavename": "bld-linux64-spot-303", 11:12:16 INFO - "version": "61.0", 11:12:16 INFO - "release_promotion": true, 11:12:16 INFO - "platform": null, 11:12:16 INFO - "branch": "birch", 11:12:16 INFO - "script_repo_revision": "36ae5fede0a2d566494ad0be54f631bf2686faea", 11:12:16 INFO - "master": "http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/", 11:12:16 INFO - "revision": "36ae5fede0a2d566494ad0be54f631bf2686faea", 11:12:16 INFO - "partial_versions": "58.0b13build1, 57.0build4", 11:12:16 INFO - "next_version": "61.0.1", 11:12:16 INFO - "repo_path": "projects/birch" 11:12:16 INFO - } 11:12:16 INFO - Overriding product with firefox 11:12:16 INFO - Overriding version with 61.0 11:12:16 INFO - Overriding build_number with 6 11:12:16 INFO - Overriding revision with 36ae5fede0a2d566494ad0be54f631bf2686faea 11:12:16 INFO - Run as scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_release.py --credentials-file oauth.txt --bouncer-api-prefix https://admin-bouncer-releng.stage.mozaws.net/api --repo projects/birch 11:12:16 INFO - Dumping config to /builds/slave/rel-bir_fx_bncr_sub-0000000000/logs/localconfig.json. 11:12:16 INFO - {'append_to_log': False, 11:12:16 INFO - 'base_work_dir': '/builds/slave/rel-bir_fx_bncr_sub-0000000000', 11:12:16 INFO - 'bouncer-api-prefix': 'https://admin-bouncer-releng.stage.mozaws.net/api', 11:12:16 INFO - 'build_number': 6, 11:12:16 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:16 INFO - 'config_files': ('releases/bouncer_firefox_release.py',), 11:12:16 INFO - 'credentials_file': 'oauth.txt', 11:12:16 INFO - 'log_level': 'info', 11:12:16 INFO - 'log_to_console': True, 11:12:16 INFO - 'opt_config_files': (), 11:12:16 INFO - 'partials': {'candidates-dir': {'add-locales': True, 11:12:16 INFO - 'check_uptake': False, 11:12:16 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 11:12:16 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 11:12:16 INFO - 'linux64': {'bouncer-platform': 'linux64', 11:12:16 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 11:12:16 INFO - 'macosx64': {'bouncer-platform': 'osx', 11:12:16 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 11:12:16 INFO - 'win32': {'bouncer-platform': 'win', 11:12:16 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 11:12:16 INFO - 'win64': {'bouncer-platform': 'win64', 11:12:16 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 11:12:16 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Partial-%(prev_version)sbuild%(prev_build_number)s', 11:12:16 INFO - 'ssl-only': False}, 11:12:16 INFO - 'releases-dir': {'add-locales': True, 11:12:16 INFO - 'check_uptake': True, 11:12:16 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 11:12:16 INFO - 'linux64': {'bouncer-platform': 'linux64', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 11:12:16 INFO - 'macosx64': {'bouncer-platform': 'osx', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 11:12:16 INFO - 'win32': {'bouncer-platform': 'win', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 11:12:16 INFO - 'win64': {'bouncer-platform': 'win64', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 11:12:16 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s', 11:12:16 INFO - 'ssl-only': False}}, 11:12:16 INFO - 'prev_versions': (u'58.0b13build1', u'57.0build4'), 11:12:16 INFO - 'product': u'firefox', 11:12:16 INFO - 'products': {'complete-mar': {'add-locales': True, 11:12:16 INFO - 'check_uptake': True, 11:12:16 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 11:12:16 INFO - 'linux64': {'bouncer-platform': 'linux64', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 11:12:16 INFO - 'macosx64': {'bouncer-platform': 'osx', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 11:12:16 INFO - 'win32': {'bouncer-platform': 'win', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 11:12:16 INFO - 'win64': {'bouncer-platform': 'win64', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 11:12:16 INFO - 'product-name': 'Firefox-%(version)s-Complete', 11:12:16 INFO - 'ssl-only': False}, 11:12:16 INFO - 'complete-mar-candidates': {'add-locales': True, 11:12:16 INFO - 'check_uptake': False, 11:12:16 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 11:12:16 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 11:12:16 INFO - 'linux64': {'bouncer-platform': 'linux64', 11:12:16 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 11:12:16 INFO - 'macosx64': {'bouncer-platform': 'osx', 11:12:16 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 11:12:16 INFO - 'win32': {'bouncer-platform': 'win', 11:12:16 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 11:12:16 INFO - 'win64': {'bouncer-platform': 'win64', 11:12:16 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 11:12:16 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete', 11:12:16 INFO - 'ssl-only': False}, 11:12:16 INFO - 'installer': {'add-locales': True, 11:12:16 INFO - 'alias': 'firefox-latest', 11:12:16 INFO - 'check_uptake': True, 11:12:16 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 11:12:16 INFO - 'linux64': {'bouncer-platform': 'linux64', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 11:12:16 INFO - 'macosx64': {'bouncer-platform': 'osx', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 11:12:16 INFO - 'win32': {'bouncer-platform': 'win', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 11:12:16 INFO - 'win64': {'bouncer-platform': 'win64', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 11:12:16 INFO - 'product-name': 'Firefox-%(version)s', 11:12:16 INFO - 'ssl-only': False}, 11:12:16 INFO - 'installer-ssl': {'add-locales': True, 11:12:16 INFO - 'alias': 'firefox-latest-ssl', 11:12:16 INFO - 'check_uptake': True, 11:12:16 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 11:12:16 INFO - 'linux64': {'bouncer-platform': 'linux64', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 11:12:16 INFO - 'macosx64': {'bouncer-platform': 'osx', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 11:12:16 INFO - 'win32': {'bouncer-platform': 'win', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 11:12:16 INFO - 'win64': {'bouncer-platform': 'win64', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 11:12:16 INFO - 'product-name': 'Firefox-%(version)s-SSL', 11:12:16 INFO - 'ssl-only': True}, 11:12:16 INFO - 'stub-installer': {'add-locales': True, 11:12:16 INFO - 'alias': 'firefox-stub', 11:12:16 INFO - 'check_uptake': True, 11:12:16 INFO - 'paths': {'win32': {'bouncer-platform': 'win', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}, 11:12:16 INFO - 'win64': {'bouncer-platform': 'win64', 11:12:16 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}}, 11:12:16 INFO - 'product-name': 'Firefox-%(version)s-stub', 11:12:16 INFO - 'ssl-only': True}}, 11:12:16 INFO - 'repo': 'projects/birch', 11:12:16 INFO - 'revision': u'36ae5fede0a2d566494ad0be54f631bf2686faea', 11:12:16 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales', 11:12:16 INFO - 'version': u'61.0', 11:12:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:16 INFO - 'work_dir': 'build'} 11:12:16 INFO - [mozharness: 2018-02-13 19:12:16.183118Z] Running clobber step. 11:12:16 INFO - Running main action method: clobber 11:12:16 INFO - rmtree: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build 11:12:16 INFO - [mozharness: 2018-02-13 19:12:16.186403Z] Finished clobber step (success) 11:12:16 INFO - [mozharness: 2018-02-13 19:12:16.186720Z] Running download-shipped-locales step. 11:12:16 INFO - Running main action method: download_shipped_locales 11:12:16 INFO - mkdir: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build 11:12:16 INFO - Downloading https://hg.mozilla.org/projects/birch/raw-file/36ae5fede0a2d566494ad0be54f631bf2686faea/browser/locales/shipped-locales to /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales 11:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://hg.mozilla.org/projects/birch/raw-file/36ae5fede0a2d566494ad0be54f631bf2686faea/browser/locales/shipped-locales', 'file_name': '/builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales'}, attempt #1 11:12:17 INFO - Downloaded 18 bytes. 11:12:17 INFO - Reading from file /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales 11:12:17 INFO - Contents: 11:12:17 INFO - de 11:12:17 INFO - en-US 11:12:17 INFO - ru 11:12:17 INFO - zh-TW 11:12:17 INFO - [mozharness: 2018-02-13 19:12:17.118379Z] Finished download-shipped-locales step (success) 11:12:17 INFO - [mozharness: 2018-02-13 19:12:17.118569Z] Running submit step. 11:12:17 INFO - Running main action method: submit 11:12:17 INFO - Checking if Firefox-61.0-Complete already exists 11:12:17 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-Complete', None), kwargs: {}, attempt #1 11:12:17 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-Complete 11:12:17 INFO - Server response 11:12:17 INFO - 11:12:17 INFO - Products found: 1 11:12:17 WARNING - Product Firefox-61.0-Complete already exists. Skipping... 11:12:17 INFO - Checking if Firefox-61.0build6-Complete already exists 11:12:17 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0build6-Complete', None), kwargs: {}, attempt #1 11:12:17 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0build6-Complete 11:12:18 INFO - Server response 11:12:18 INFO - 11:12:18 INFO - Products found: 0 11:12:18 INFO - Adding complete-mar-candidates... 11:12:18 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'ru', 'zh-TW'], 'product': u'Firefox-61.0build6-Complete'}), kwargs: {}, attempt #1 11:12:18 INFO - POST data: languages=de&languages=en-US&languages=ru&languages=zh-TW&product=Firefox-61.0build6-Complete 11:12:18 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/ 11:12:19 INFO - Server response 11:12:19 INFO - 11:12:19 INFO - Adding paths... 11:12:19 INFO - linux (linux): /firefox/candidates/61.0-candidates/build6/update/linux-i686/:lang/firefox-61.0.complete.mar 11:12:19 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/linux-i686/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build6-Complete', 'os': 'linux'}), kwargs: {}, attempt #1 11:12:19 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build6-Complete&os=linux 11:12:19 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:19 INFO - Server response 11:12:19 INFO - /firefox/candidates/61.0-candidates/build6/update/linux-i686/:lang/firefox-61.0.complete.mar 11:12:19 INFO - linux64 (linux64): /firefox/candidates/61.0-candidates/build6/update/linux-x86_64/:lang/firefox-61.0.complete.mar 11:12:19 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/linux-x86_64/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build6-Complete', 'os': 'linux64'}), kwargs: {}, attempt #1 11:12:19 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build6-Complete&os=linux64 11:12:19 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:20 INFO - Server response 11:12:20 INFO - /firefox/candidates/61.0-candidates/build6/update/linux-x86_64/:lang/firefox-61.0.complete.mar 11:12:20 INFO - macosx64 (osx): /firefox/candidates/61.0-candidates/build6/update/mac/:lang/firefox-61.0.complete.mar 11:12:20 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/mac/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build6-Complete', 'os': 'osx'}), kwargs: {}, attempt #1 11:12:20 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build6-Complete&os=osx 11:12:20 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:20 INFO - Server response 11:12:20 INFO - /firefox/candidates/61.0-candidates/build6/update/mac/:lang/firefox-61.0.complete.mar 11:12:20 INFO - win32 (win): /firefox/candidates/61.0-candidates/build6/update/win32/:lang/firefox-61.0.complete.mar 11:12:20 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/win32/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build6-Complete', 'os': 'win'}), kwargs: {}, attempt #1 11:12:20 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build6-Complete&os=win 11:12:20 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:21 INFO - Server response 11:12:21 INFO - /firefox/candidates/61.0-candidates/build6/update/win32/:lang/firefox-61.0.complete.mar 11:12:21 INFO - win64 (win64): /firefox/candidates/61.0-candidates/build6/update/win64/:lang/firefox-61.0.complete.mar 11:12:21 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/win64/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build6-Complete', 'os': 'win64'}), kwargs: {}, attempt #1 11:12:21 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build6-Complete&os=win64 11:12:21 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:22 INFO - Server response 11:12:22 INFO - /firefox/candidates/61.0-candidates/build6/update/win64/:lang/firefox-61.0.complete.mar 11:12:22 INFO - Checking if Firefox-61.0 already exists 11:12:22 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0', None), kwargs: {}, attempt #1 11:12:22 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0 11:12:22 INFO - Server response 11:12:22 INFO - 11:12:22 INFO - Products found: 1 11:12:22 WARNING - Product Firefox-61.0 already exists. Skipping... 11:12:22 INFO - Checking if Firefox-61.0-SSL already exists 11:12:22 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-SSL', None), kwargs: {}, attempt #1 11:12:22 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-SSL 11:12:23 INFO - Server response 11:12:23 INFO - 11:12:23 INFO - Products found: 1 11:12:23 WARNING - Product Firefox-61.0-SSL already exists. Skipping... 11:12:23 INFO - Checking if Firefox-61.0-stub already exists 11:12:23 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-stub', None), kwargs: {}, attempt #1 11:12:23 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-stub 11:12:23 INFO - Server response 11:12:23 INFO - 11:12:23 INFO - Products found: 1 11:12:23 WARNING - Product Firefox-61.0-stub already exists. Skipping... 11:12:23 INFO - Checking if Firefox-61.0build6-Partial-58.0b13build1 already exists 11:12:23 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0build6-Partial-58.0b13build1', None), kwargs: {}, attempt #1 11:12:23 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0build6-Partial-58.0b13build1 11:12:24 INFO - Server response 11:12:24 INFO - 11:12:24 INFO - Products found: 0 11:12:24 INFO - Adding partial updates for Firefox-61.0build6-Partial-58.0b13build1 11:12:24 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'ru', 'zh-TW'], 'product': u'Firefox-61.0build6-Partial-58.0b13build1'}), kwargs: {}, attempt #1 11:12:24 INFO - POST data: languages=de&languages=en-US&languages=ru&languages=zh-TW&product=Firefox-61.0build6-Partial-58.0b13build1 11:12:24 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/ 11:12:25 INFO - Server response 11:12:25 INFO - 11:12:25 INFO - linux (linux): /firefox/candidates/61.0-candidates/build6/update/linux-i686/:lang/firefox-58.0b13-61.0.partial.mar 11:12:25 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/linux-i686/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build6-Partial-58.0b13build1', 'os': 'linux'}), kwargs: {}, attempt #1 11:12:25 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build6-Partial-58.0b13build1&os=linux 11:12:25 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:25 INFO - Server response 11:12:25 INFO - /firefox/candidates/61.0-candidates/build6/update/linux-i686/:lang/firefox-58.0b13-61.0.partial.mar 11:12:25 INFO - linux64 (linux64): /firefox/candidates/61.0-candidates/build6/update/linux-x86_64/:lang/firefox-58.0b13-61.0.partial.mar 11:12:25 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/linux-x86_64/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build6-Partial-58.0b13build1', 'os': 'linux64'}), kwargs: {}, attempt #1 11:12:25 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build6-Partial-58.0b13build1&os=linux64 11:12:25 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:26 INFO - Server response 11:12:26 INFO - /firefox/candidates/61.0-candidates/build6/update/linux-x86_64/:lang/firefox-58.0b13-61.0.partial.mar 11:12:26 INFO - macosx64 (osx): /firefox/candidates/61.0-candidates/build6/update/mac/:lang/firefox-58.0b13-61.0.partial.mar 11:12:26 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/mac/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build6-Partial-58.0b13build1', 'os': 'osx'}), kwargs: {}, attempt #1 11:12:26 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build6-Partial-58.0b13build1&os=osx 11:12:26 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:26 INFO - Server response 11:12:26 INFO - /firefox/candidates/61.0-candidates/build6/update/mac/:lang/firefox-58.0b13-61.0.partial.mar 11:12:26 INFO - win32 (win): /firefox/candidates/61.0-candidates/build6/update/win32/:lang/firefox-58.0b13-61.0.partial.mar 11:12:26 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/win32/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build6-Partial-58.0b13build1', 'os': 'win'}), kwargs: {}, attempt #1 11:12:26 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build6-Partial-58.0b13build1&os=win 11:12:26 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:27 INFO - Server response 11:12:27 INFO - /firefox/candidates/61.0-candidates/build6/update/win32/:lang/firefox-58.0b13-61.0.partial.mar 11:12:27 INFO - win64 (win64): /firefox/candidates/61.0-candidates/build6/update/win64/:lang/firefox-58.0b13-61.0.partial.mar 11:12:27 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/win64/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build6-Partial-58.0b13build1', 'os': 'win64'}), kwargs: {}, attempt #1 11:12:27 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build6-Partial-58.0b13build1&os=win64 11:12:27 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:28 INFO - Server response 11:12:28 INFO - /firefox/candidates/61.0-candidates/build6/update/win64/:lang/firefox-58.0b13-61.0.partial.mar 11:12:28 INFO - Checking if Firefox-61.0build6-Partial-57.0build4 already exists 11:12:28 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0build6-Partial-57.0build4', None), kwargs: {}, attempt #1 11:12:28 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0build6-Partial-57.0build4 11:12:28 INFO - Server response 11:12:28 INFO - 11:12:28 INFO - Products found: 0 11:12:28 INFO - Adding partial updates for Firefox-61.0build6-Partial-57.0build4 11:12:28 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'ru', 'zh-TW'], 'product': u'Firefox-61.0build6-Partial-57.0build4'}), kwargs: {}, attempt #1 11:12:28 INFO - POST data: languages=de&languages=en-US&languages=ru&languages=zh-TW&product=Firefox-61.0build6-Partial-57.0build4 11:12:28 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/ 11:12:29 INFO - Server response 11:12:29 INFO - 11:12:29 INFO - linux (linux): /firefox/candidates/61.0-candidates/build6/update/linux-i686/:lang/firefox-57.0-61.0.partial.mar 11:12:29 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/linux-i686/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build6-Partial-57.0build4', 'os': 'linux'}), kwargs: {}, attempt #1 11:12:29 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build6-Partial-57.0build4&os=linux 11:12:29 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:30 INFO - Server response 11:12:30 INFO - /firefox/candidates/61.0-candidates/build6/update/linux-i686/:lang/firefox-57.0-61.0.partial.mar 11:12:30 INFO - linux64 (linux64): /firefox/candidates/61.0-candidates/build6/update/linux-x86_64/:lang/firefox-57.0-61.0.partial.mar 11:12:30 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/linux-x86_64/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build6-Partial-57.0build4', 'os': 'linux64'}), kwargs: {}, attempt #1 11:12:30 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build6-Partial-57.0build4&os=linux64 11:12:30 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:30 INFO - Server response 11:12:30 INFO - /firefox/candidates/61.0-candidates/build6/update/linux-x86_64/:lang/firefox-57.0-61.0.partial.mar 11:12:30 INFO - macosx64 (osx): /firefox/candidates/61.0-candidates/build6/update/mac/:lang/firefox-57.0-61.0.partial.mar 11:12:30 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/mac/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build6-Partial-57.0build4', 'os': 'osx'}), kwargs: {}, attempt #1 11:12:30 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build6-Partial-57.0build4&os=osx 11:12:30 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:31 INFO - Server response 11:12:31 INFO - /firefox/candidates/61.0-candidates/build6/update/mac/:lang/firefox-57.0-61.0.partial.mar 11:12:31 INFO - win32 (win): /firefox/candidates/61.0-candidates/build6/update/win32/:lang/firefox-57.0-61.0.partial.mar 11:12:31 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/win32/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build6-Partial-57.0build4', 'os': 'win'}), kwargs: {}, attempt #1 11:12:31 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build6-Partial-57.0build4&os=win 11:12:31 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:31 INFO - Server response 11:12:31 INFO - /firefox/candidates/61.0-candidates/build6/update/win32/:lang/firefox-57.0-61.0.partial.mar 11:12:31 INFO - win64 (win64): /firefox/candidates/61.0-candidates/build6/update/win64/:lang/firefox-57.0-61.0.partial.mar 11:12:31 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build6/update/win64/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build6-Partial-57.0build4', 'os': 'win64'}), kwargs: {}, attempt #1 11:12:31 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild6%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build6-Partial-57.0build4&os=win64 11:12:31 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 11:12:32 INFO - Server response 11:12:32 INFO - /firefox/candidates/61.0-candidates/build6/update/win64/:lang/firefox-57.0-61.0.partial.mar 11:12:32 INFO - Checking if Firefox-61.0-Partial-58.0b13 already exists 11:12:32 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-Partial-58.0b13', None), kwargs: {}, attempt #1 11:12:32 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-Partial-58.0b13 11:12:33 INFO - Server response 11:12:33 INFO - 11:12:33 INFO - Products found: 1 11:12:33 WARNING - Product Firefox-61.0-Partial-58.0b13 already exists. Skipping... 11:12:33 INFO - Checking if Firefox-61.0-Partial-57.0 already exists 11:12:33 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-Partial-57.0', None), kwargs: {}, attempt #1 11:12:33 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-Partial-57.0 11:12:33 INFO - Server response 11:12:33 INFO - 11:12:33 INFO - Products found: 1 11:12:33 WARNING - Product Firefox-61.0-Partial-57.0 already exists. Skipping... 11:12:33 INFO - [mozharness: 2018-02-13 19:12:33.743281Z] Finished submit step (success) 11:12:33 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:33 INFO - Copying logs to upload dir... 11:12:33 INFO - mkdir: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/upload/logs 11:12:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=17.848281 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 17 secs) (at 2018-02-13 11:12:33.765246) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2018-02-13 11:12:33.767874) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-bir_fx_bncr_sub-0000000000/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-303.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-bir_fx_bncr_sub-0000000000/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.005178 ========= master_lag: 0.05 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2018-02-13 11:12:33.819551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-02-13 11:12:33.819861) ========= rm -f oauth.txt in dir /builds/slave/rel-bir_fx_bncr_sub-0000000000/. (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-303.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-bir_fx_bncr_sub-0000000000 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.003078 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-02-13 11:12:33.867084) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2018-02-13 11:12:33.867362) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2018-02-13 11:12:33.867594) ========= ========= Total master_lag: 0.26 =========