builder: release-birch_firefox_bncr_sub
slave: bld-linux64-spot-303
starttime: 1515187001.89
results: success (0)
revision: 2b48be93f5837430d5ef6601799fd721d664e8a5
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:41.889295) =========
master: http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:41.889733) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:41.890045) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:41.948278) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:41.948561) =========
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-01-05 13:16:41-- 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% 100M=0s
2018-01-05 13:16:42 (100 MB/s) - ‘archiver_client.py’ saved [12179/12179]
program finished with exit code 0
elapsedTime=0.214091
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:42.173397) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:42.173717) =========
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.002820
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:42.221383) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:42.221701) =========
bash -c 'python archiver_client.py mozharness --repo projects/birch --rev 2b48be93f5837430d5ef6601799fd721d664e8a5 --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 2b48be93f5837430d5ef6601799fd721d664e8a5 --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-01-05 13:16:42,269 truncating revision to first 12 chars
2018-01-05 13:16:42,269 Setting DEBUG logging.
2018-01-05 13:16:42,269 attempt 1/10
2018-01-05 13:16:42,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/birch/2b48be93f583?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2018-01-05 13:16:42,931 unpacking tar archive at: birch-2b48be93f583/testing/mozharness/
program finished with exit code 0
elapsedTime=0.876960
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:43.107901) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:43.108224) =========
script_repo_revision: 2b48be93f5837430d5ef6601799fd721d664e8a5
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:43.108590) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:43.108908) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-01-05 13:16:43.115664) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 27 secs) (at 2018-01-05 13:16:43.115973) =========
/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
13:16:43 INFO - MultiFileLogger online at 20180105 13:16:43 in /builds/slave/rel-bir_fx_bncr_sub-0000000000
13:16:43 INFO - Using buildbot properties:
13:16:43 INFO - {
13:16:43 INFO - "project": "",
13:16:43 INFO - "product": "firefox",
13:16:43 INFO - "build_number": 8,
13:16:43 INFO - "taskId": "BiiApeGhR_iNunPABh4jXw",
13:16:43 INFO - "repository": "https://hg.mozilla.org/projects/birch",
13:16:43 INFO - "buildername": "release-birch_firefox_bncr_sub",
13:16:43 INFO - "balrog_api_root": "https://balrog-admin.stage.mozaws.net/api",
13:16:43 INFO - "basedir": "/builds/slave/rel-bir_fx_bncr_sub-0000000000",
13:16:43 INFO - "appVersion": "58.0",
13:16:43 INFO - "buildnumber": 1,
13:16:43 INFO - "slavename": "bld-linux64-spot-303",
13:16:43 INFO - "version": "58.0",
13:16:43 INFO - "release_promotion": true,
13:16:43 INFO - "platform": null,
13:16:43 INFO - "branch": "birch",
13:16:43 INFO - "script_repo_revision": "2b48be93f5837430d5ef6601799fd721d664e8a5",
13:16:43 INFO - "master": "http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/",
13:16:43 INFO - "revision": "2b48be93f5837430d5ef6601799fd721d664e8a5",
13:16:43 INFO - "partial_versions": "58.0b13build1, 57.0.2build2",
13:16:43 INFO - "next_version": "58.0.1",
13:16:43 INFO - "repo_path": "projects/birch"
13:16:43 INFO - }
13:16:43 INFO - Overriding product with firefox
13:16:43 INFO - Overriding version with 58.0
13:16:43 INFO - Overriding build_number with 8
13:16:43 INFO - Overriding revision with 2b48be93f5837430d5ef6601799fd721d664e8a5
13:16:43 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
13:16:43 INFO - Dumping config to /builds/slave/rel-bir_fx_bncr_sub-0000000000/logs/localconfig.json.
13:16:43 INFO - {'append_to_log': False,
13:16:43 INFO - 'base_work_dir': '/builds/slave/rel-bir_fx_bncr_sub-0000000000',
13:16:43 INFO - 'bouncer-api-prefix': 'https://admin-bouncer-releng.stage.mozaws.net/api',
13:16:43 INFO - 'build_number': 8,
13:16:43 INFO - 'buildbot_json_path': 'buildprops.json',
13:16:43 INFO - 'config_files': ('releases/bouncer_firefox_release.py',),
13:16:43 INFO - 'credentials_file': 'oauth.txt',
13:16:43 INFO - 'log_level': 'info',
13:16:43 INFO - 'log_to_console': True,
13:16:43 INFO - 'opt_config_files': (),
13:16:43 INFO - 'partials': {'candidates-dir': {'add-locales': True,
13:16:43 INFO - 'check_uptake': False,
13:16:43 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
13:16:43 INFO - 'linux64': {'bouncer-platform': 'linux64',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
13:16:43 INFO - 'macosx64': {'bouncer-platform': 'osx',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
13:16:43 INFO - 'win32': {'bouncer-platform': 'win',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
13:16:43 INFO - 'win64': {'bouncer-platform': 'win64',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
13:16:43 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Partial-%(prev_version)sbuild%(prev_build_number)s',
13:16:43 INFO - 'ssl-only': False},
13:16:43 INFO - 'releases-dir': {'add-locales': True,
13:16:43 INFO - 'check_uptake': True,
13:16:43 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
13:16:43 INFO - 'linux64': {'bouncer-platform': 'linux64',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
13:16:43 INFO - 'macosx64': {'bouncer-platform': 'osx',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
13:16:43 INFO - 'win32': {'bouncer-platform': 'win',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
13:16:43 INFO - 'win64': {'bouncer-platform': 'win64',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
13:16:43 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s',
13:16:43 INFO - 'ssl-only': False}},
13:16:43 INFO - 'prev_versions': (u'58.0b13build1', u'57.0.2build2'),
13:16:43 INFO - 'product': u'firefox',
13:16:43 INFO - 'products': {'complete-mar': {'add-locales': True,
13:16:43 INFO - 'check_uptake': True,
13:16:43 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
13:16:43 INFO - 'linux64': {'bouncer-platform': 'linux64',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
13:16:43 INFO - 'macosx64': {'bouncer-platform': 'osx',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
13:16:43 INFO - 'win32': {'bouncer-platform': 'win',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
13:16:43 INFO - 'win64': {'bouncer-platform': 'win64',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
13:16:43 INFO - 'product-name': 'Firefox-%(version)s-Complete',
13:16:43 INFO - 'ssl-only': False},
13:16:43 INFO - 'complete-mar-bz2': {'add-locales': True,
13:16:43 INFO - 'check_uptake': True,
13:16:43 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.bz2.complete.mar'},
13:16:43 INFO - 'linux64': {'bouncer-platform': 'linux64',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.bz2.complete.mar'},
13:16:43 INFO - 'macosx64': {'bouncer-platform': 'osx',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.bz2.complete.mar'},
13:16:43 INFO - 'win32': {'bouncer-platform': 'win',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.bz2.complete.mar'},
13:16:43 INFO - 'win64': {'bouncer-platform': 'win64',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.bz2.complete.mar'}},
13:16:43 INFO - 'product-name': 'Firefox-%(version)s-Complete-bz2',
13:16:43 INFO - 'ssl-only': False},
13:16:43 INFO - 'complete-mar-candidates': {'add-locales': True,
13:16:43 INFO - 'check_uptake': False,
13:16:43 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
13:16:43 INFO - 'linux64': {'bouncer-platform': 'linux64',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
13:16:43 INFO - 'macosx64': {'bouncer-platform': 'osx',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
13:16:43 INFO - 'win32': {'bouncer-platform': 'win',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
13:16:43 INFO - 'win64': {'bouncer-platform': 'win64',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
13:16:43 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete',
13:16:43 INFO - 'ssl-only': False},
13:16:43 INFO - 'complete-mar-candidates-bz2': {'add-locales': True,
13:16:43 INFO - 'check_uptake': False,
13:16:43 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.bz2.complete.mar'},
13:16:43 INFO - 'linux64': {'bouncer-platform': 'linux64',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.bz2.complete.mar'},
13:16:43 INFO - 'macosx64': {'bouncer-platform': 'osx',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.bz2.complete.mar'},
13:16:43 INFO - 'win32': {'bouncer-platform': 'win',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.bz2.complete.mar'},
13:16:43 INFO - 'win64': {'bouncer-platform': 'win64',
13:16:43 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.bz2.complete.mar'}},
13:16:43 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete-bz2',
13:16:43 INFO - 'ssl-only': False},
13:16:43 INFO - 'installer': {'add-locales': True,
13:16:43 INFO - 'alias': 'firefox-latest',
13:16:43 INFO - 'check_uptake': True,
13:16:43 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
13:16:43 INFO - 'linux64': {'bouncer-platform': 'linux64',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
13:16:43 INFO - 'macosx64': {'bouncer-platform': 'osx',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
13:16:43 INFO - 'win32': {'bouncer-platform': 'win',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
13:16:43 INFO - 'win64': {'bouncer-platform': 'win64',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
13:16:43 INFO - 'product-name': 'Firefox-%(version)s',
13:16:43 INFO - 'ssl-only': False},
13:16:43 INFO - 'installer-ssl': {'add-locales': True,
13:16:43 INFO - 'alias': 'firefox-latest-ssl',
13:16:43 INFO - 'check_uptake': True,
13:16:43 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
13:16:43 INFO - 'linux64': {'bouncer-platform': 'linux64',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
13:16:43 INFO - 'macosx64': {'bouncer-platform': 'osx',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
13:16:43 INFO - 'win32': {'bouncer-platform': 'win',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
13:16:43 INFO - 'win64': {'bouncer-platform': 'win64',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
13:16:43 INFO - 'product-name': 'Firefox-%(version)s-SSL',
13:16:43 INFO - 'ssl-only': True},
13:16:43 INFO - 'stub-installer': {'add-locales': True,
13:16:43 INFO - 'alias': 'firefox-stub',
13:16:43 INFO - 'check_uptake': True,
13:16:43 INFO - 'paths': {'win32': {'bouncer-platform': 'win',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'},
13:16:43 INFO - 'win64': {'bouncer-platform': 'win64',
13:16:43 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}},
13:16:43 INFO - 'product-name': 'Firefox-%(version)s-stub',
13:16:43 INFO - 'ssl-only': True}},
13:16:43 INFO - 'repo': 'projects/birch',
13:16:43 INFO - 'revision': u'2b48be93f5837430d5ef6601799fd721d664e8a5',
13:16:43 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales',
13:16:43 INFO - 'version': u'58.0',
13:16:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
13:16:43 INFO - 'work_dir': 'build'}
13:16:43 INFO - [mozharness: 2018-01-05 21:16:43.323224Z] Running clobber step.
13:16:43 INFO - Running main action method: clobber
13:16:43 INFO - rmtree: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build
13:16:43 INFO - [mozharness: 2018-01-05 21:16:43.326745Z] Finished clobber step (success)
13:16:43 INFO - [mozharness: 2018-01-05 21:16:43.327099Z] Running download-shipped-locales step.
13:16:43 INFO - Running main action method: download_shipped_locales
13:16:43 INFO - mkdir: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build
13:16:43 INFO - Downloading https://hg.mozilla.org/projects/birch/raw-file/2b48be93f5837430d5ef6601799fd721d664e8a5/browser/locales/shipped-locales to /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales
13:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://hg.mozilla.org/projects/birch/raw-file/2b48be93f5837430d5ef6601799fd721d664e8a5/browser/locales/shipped-locales', 'file_name': '/builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales'}, attempt #1
13:16:44 INFO - Downloaded 15 bytes.
13:16:44 INFO - Reading from file /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales
13:16:44 INFO - Contents:
13:16:44 INFO - de
13:16:44 INFO - en-US
13:16:44 INFO - zh-TW
13:16:44 INFO - [mozharness: 2018-01-05 21:16:44.342723Z] Finished download-shipped-locales step (success)
13:16:44 INFO - [mozharness: 2018-01-05 21:16:44.342972Z] Running submit step.
13:16:44 INFO - Running main action method: submit
13:16:44 INFO - Checking if Firefox-58.0-Complete already exists
13:16:44 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-58.0-Complete', None), kwargs: {}, attempt #1
13:16:44 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-58.0-Complete
13:16:44 INFO - Server response
13:16:44 INFO -
13:16:44 INFO - Products found: 1
13:16:44 WARNING - Product Firefox-58.0-Complete already exists. Skipping...
13:16:44 INFO - Checking if Firefox-58.0-Complete-bz2 already exists
13:16:44 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-58.0-Complete-bz2', None), kwargs: {}, attempt #1
13:16:44 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-58.0-Complete-bz2
13:16:45 INFO - Server response
13:16:45 INFO -
13:16:45 INFO - Products found: 1
13:16:45 WARNING - Product Firefox-58.0-Complete-bz2 already exists. Skipping...
13:16:45 INFO - Checking if Firefox-58.0build8-Complete already exists
13:16:45 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-58.0build8-Complete', None), kwargs: {}, attempt #1
13:16:45 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-58.0build8-Complete
13:16:46 INFO - Server response
13:16:46 INFO -
13:16:46 INFO - Products found: 0
13:16:46 INFO - Adding complete-mar-candidates...
13:16:46 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'zh-TW'], 'product': u'Firefox-58.0build8-Complete'}), kwargs: {}, attempt #1
13:16:46 INFO - POST data: languages=de&languages=en-US&languages=zh-TW&product=Firefox-58.0build8-Complete
13:16:46 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
13:16:47 INFO - Server response
13:16:47 INFO -
13:16:47 INFO - Adding paths...
13:16:47 INFO - linux (linux): /firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-58.0.complete.mar
13:16:47 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-58.0.complete.mar', 'product': u'Firefox-58.0build8-Complete', 'os': 'linux'}), kwargs: {}, attempt #1
13:16:47 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-58.0.complete.mar&product=Firefox-58.0build8-Complete&os=linux
13:16:47 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:47 INFO - Server response
13:16:47 INFO - /firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-58.0.complete.mar
13:16:47 INFO - linux64 (linux64): /firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-58.0.complete.mar
13:16:47 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-58.0.complete.mar', 'product': u'Firefox-58.0build8-Complete', 'os': 'linux64'}), kwargs: {}, attempt #1
13:16:47 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-58.0.complete.mar&product=Firefox-58.0build8-Complete&os=linux64
13:16:47 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:48 INFO - Server response
13:16:48 INFO - /firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-58.0.complete.mar
13:16:48 INFO - macosx64 (osx): /firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-58.0.complete.mar
13:16:48 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-58.0.complete.mar', 'product': u'Firefox-58.0build8-Complete', 'os': 'osx'}), kwargs: {}, attempt #1
13:16:48 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-58.0.complete.mar&product=Firefox-58.0build8-Complete&os=osx
13:16:48 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:49 INFO - Server response
13:16:49 INFO - /firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-58.0.complete.mar
13:16:49 INFO - win32 (win): /firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-58.0.complete.mar
13:16:49 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-58.0.complete.mar', 'product': u'Firefox-58.0build8-Complete', 'os': 'win'}), kwargs: {}, attempt #1
13:16:49 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-58.0.complete.mar&product=Firefox-58.0build8-Complete&os=win
13:16:49 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:49 INFO - Server response
13:16:49 INFO - /firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-58.0.complete.mar
13:16:49 INFO - win64 (win64): /firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-58.0.complete.mar
13:16:49 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-58.0.complete.mar', 'product': u'Firefox-58.0build8-Complete', 'os': 'win64'}), kwargs: {}, attempt #1
13:16:49 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-58.0.complete.mar&product=Firefox-58.0build8-Complete&os=win64
13:16:49 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:50 INFO - Server response
13:16:50 INFO - /firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-58.0.complete.mar
13:16:50 INFO - Checking if Firefox-58.0build8-Complete-bz2 already exists
13:16:50 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-58.0build8-Complete-bz2', None), kwargs: {}, attempt #1
13:16:50 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-58.0build8-Complete-bz2
13:16:51 INFO - Server response
13:16:51 INFO -
13:16:51 INFO - Products found: 0
13:16:51 INFO - Adding complete-mar-candidates-bz2...
13:16:51 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'zh-TW'], 'product': u'Firefox-58.0build8-Complete-bz2'}), kwargs: {}, attempt #1
13:16:51 INFO - POST data: languages=de&languages=en-US&languages=zh-TW&product=Firefox-58.0build8-Complete-bz2
13:16:51 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
13:16:51 INFO - Server response
13:16:51 INFO -
13:16:51 INFO - Adding paths...
13:16:51 INFO - linux (linux): /firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-58.0.bz2.complete.mar
13:16:51 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-58.0.bz2.complete.mar', 'product': u'Firefox-58.0build8-Complete-bz2', 'os': 'linux'}), kwargs: {}, attempt #1
13:16:51 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-58.0.bz2.complete.mar&product=Firefox-58.0build8-Complete-bz2&os=linux
13:16:51 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:52 INFO - Server response
13:16:52 INFO - /firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-58.0.bz2.complete.mar
13:16:52 INFO - linux64 (linux64): /firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-58.0.bz2.complete.mar
13:16:52 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-58.0.bz2.complete.mar', 'product': u'Firefox-58.0build8-Complete-bz2', 'os': 'linux64'}), kwargs: {}, attempt #1
13:16:52 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-58.0.bz2.complete.mar&product=Firefox-58.0build8-Complete-bz2&os=linux64
13:16:52 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:53 INFO - Server response
13:16:53 INFO - /firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-58.0.bz2.complete.mar
13:16:53 INFO - macosx64 (osx): /firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-58.0.bz2.complete.mar
13:16:53 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-58.0.bz2.complete.mar', 'product': u'Firefox-58.0build8-Complete-bz2', 'os': 'osx'}), kwargs: {}, attempt #1
13:16:53 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-58.0.bz2.complete.mar&product=Firefox-58.0build8-Complete-bz2&os=osx
13:16:53 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:53 INFO - Server response
13:16:53 INFO - /firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-58.0.bz2.complete.mar
13:16:53 INFO - win32 (win): /firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-58.0.bz2.complete.mar
13:16:53 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-58.0.bz2.complete.mar', 'product': u'Firefox-58.0build8-Complete-bz2', 'os': 'win'}), kwargs: {}, attempt #1
13:16:53 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-58.0.bz2.complete.mar&product=Firefox-58.0build8-Complete-bz2&os=win
13:16:53 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:54 INFO - Server response
13:16:54 INFO - /firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-58.0.bz2.complete.mar
13:16:54 INFO - win64 (win64): /firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-58.0.bz2.complete.mar
13:16:54 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-58.0.bz2.complete.mar', 'product': u'Firefox-58.0build8-Complete-bz2', 'os': 'win64'}), kwargs: {}, attempt #1
13:16:54 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-58.0.bz2.complete.mar&product=Firefox-58.0build8-Complete-bz2&os=win64
13:16:54 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:55 INFO - Server response
13:16:55 INFO - /firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-58.0.bz2.complete.mar
13:16:55 INFO - Checking if Firefox-58.0 already exists
13:16:55 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-58.0', None), kwargs: {}, attempt #1
13:16:55 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-58.0
13:16:55 INFO - Server response
13:16:55 INFO -
13:16:55 INFO - Products found: 1
13:16:55 WARNING - Product Firefox-58.0 already exists. Skipping...
13:16:55 INFO - Checking if Firefox-58.0-SSL already exists
13:16:55 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-58.0-SSL', None), kwargs: {}, attempt #1
13:16:55 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-58.0-SSL
13:16:56 INFO - Server response
13:16:56 INFO -
13:16:56 INFO - Products found: 1
13:16:56 WARNING - Product Firefox-58.0-SSL already exists. Skipping...
13:16:56 INFO - Checking if Firefox-58.0-stub already exists
13:16:56 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-58.0-stub', None), kwargs: {}, attempt #1
13:16:56 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-58.0-stub
13:16:56 INFO - Server response
13:16:56 INFO -
13:16:56 INFO - Products found: 1
13:16:56 WARNING - Product Firefox-58.0-stub already exists. Skipping...
13:16:56 INFO - Checking if Firefox-58.0build8-Partial-58.0b13build1 already exists
13:16:56 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-58.0build8-Partial-58.0b13build1', None), kwargs: {}, attempt #1
13:16:56 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-58.0build8-Partial-58.0b13build1
13:16:57 INFO - Server response
13:16:57 INFO -
13:16:57 INFO - Products found: 0
13:16:57 INFO - Adding partial updates for Firefox-58.0build8-Partial-58.0b13build1
13:16:57 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'zh-TW'], 'product': u'Firefox-58.0build8-Partial-58.0b13build1'}), kwargs: {}, attempt #1
13:16:57 INFO - POST data: languages=de&languages=en-US&languages=zh-TW&product=Firefox-58.0build8-Partial-58.0b13build1
13:16:57 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
13:16:58 INFO - Server response
13:16:58 INFO -
13:16:58 INFO - linux (linux): /firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-58.0b13-58.0.partial.mar
13:16:58 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-58.0b13-58.0.partial.mar', 'product': u'Firefox-58.0build8-Partial-58.0b13build1', 'os': 'linux'}), kwargs: {}, attempt #1
13:16:58 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-58.0b13-58.0.partial.mar&product=Firefox-58.0build8-Partial-58.0b13build1&os=linux
13:16:58 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:58 INFO - Server response
13:16:58 INFO - /firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-58.0b13-58.0.partial.mar
13:16:58 INFO - linux64 (linux64): /firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-58.0b13-58.0.partial.mar
13:16:58 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-58.0b13-58.0.partial.mar', 'product': u'Firefox-58.0build8-Partial-58.0b13build1', 'os': 'linux64'}), kwargs: {}, attempt #1
13:16:58 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-58.0b13-58.0.partial.mar&product=Firefox-58.0build8-Partial-58.0b13build1&os=linux64
13:16:58 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:16:59 INFO - Server response
13:16:59 INFO - /firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-58.0b13-58.0.partial.mar
13:16:59 INFO - macosx64 (osx): /firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-58.0b13-58.0.partial.mar
13:16:59 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-58.0b13-58.0.partial.mar', 'product': u'Firefox-58.0build8-Partial-58.0b13build1', 'os': 'osx'}), kwargs: {}, attempt #1
13:16:59 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-58.0b13-58.0.partial.mar&product=Firefox-58.0build8-Partial-58.0b13build1&os=osx
13:16:59 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:00 INFO - Server response
13:17:00 INFO - /firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-58.0b13-58.0.partial.mar
13:17:00 INFO - win32 (win): /firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-58.0b13-58.0.partial.mar
13:17:00 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-58.0b13-58.0.partial.mar', 'product': u'Firefox-58.0build8-Partial-58.0b13build1', 'os': 'win'}), kwargs: {}, attempt #1
13:17:00 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-58.0b13-58.0.partial.mar&product=Firefox-58.0build8-Partial-58.0b13build1&os=win
13:17:00 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:00 INFO - Server response
13:17:00 INFO - /firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-58.0b13-58.0.partial.mar
13:17:00 INFO - win64 (win64): /firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-58.0b13-58.0.partial.mar
13:17:00 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-58.0b13-58.0.partial.mar', 'product': u'Firefox-58.0build8-Partial-58.0b13build1', 'os': 'win64'}), kwargs: {}, attempt #1
13:17:00 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-58.0b13-58.0.partial.mar&product=Firefox-58.0build8-Partial-58.0b13build1&os=win64
13:17:00 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:01 INFO - Server response
13:17:01 INFO - /firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-58.0b13-58.0.partial.mar
13:17:01 INFO - Checking if Firefox-58.0build8-Partial-57.0.2build2 already exists
13:17:01 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-58.0build8-Partial-57.0.2build2', None), kwargs: {}, attempt #1
13:17:01 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-58.0build8-Partial-57.0.2build2
13:17:01 INFO - Server response
13:17:01 INFO -
13:17:01 INFO - Products found: 0
13:17:01 INFO - Adding partial updates for Firefox-58.0build8-Partial-57.0.2build2
13:17:01 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'zh-TW'], 'product': u'Firefox-58.0build8-Partial-57.0.2build2'}), kwargs: {}, attempt #1
13:17:01 INFO - POST data: languages=de&languages=en-US&languages=zh-TW&product=Firefox-58.0build8-Partial-57.0.2build2
13:17:01 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
13:17:02 INFO - Server response
13:17:02 INFO -
13:17:02 INFO - linux (linux): /firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-57.0.2-58.0.partial.mar
13:17:02 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-57.0.2-58.0.partial.mar', 'product': u'Firefox-58.0build8-Partial-57.0.2build2', 'os': 'linux'}), kwargs: {}, attempt #1
13:17:02 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-57.0.2-58.0.partial.mar&product=Firefox-58.0build8-Partial-57.0.2build2&os=linux
13:17:02 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:03 INFO - Server response
13:17:03 INFO - /firefox/candidates/58.0-candidates/build8/update/linux-i686/:lang/firefox-57.0.2-58.0.partial.mar
13:17:03 INFO - linux64 (linux64): /firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-57.0.2-58.0.partial.mar
13:17:03 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-57.0.2-58.0.partial.mar', 'product': u'Firefox-58.0build8-Partial-57.0.2build2', 'os': 'linux64'}), kwargs: {}, attempt #1
13:17:03 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-57.0.2-58.0.partial.mar&product=Firefox-58.0build8-Partial-57.0.2build2&os=linux64
13:17:03 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:03 INFO - Server response
13:17:03 INFO - /firefox/candidates/58.0-candidates/build8/update/linux-x86_64/:lang/firefox-57.0.2-58.0.partial.mar
13:17:03 INFO - macosx64 (osx): /firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-57.0.2-58.0.partial.mar
13:17:03 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-57.0.2-58.0.partial.mar', 'product': u'Firefox-58.0build8-Partial-57.0.2build2', 'os': 'osx'}), kwargs: {}, attempt #1
13:17:03 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-57.0.2-58.0.partial.mar&product=Firefox-58.0build8-Partial-57.0.2build2&os=osx
13:17:03 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:04 INFO - Server response
13:17:04 INFO - /firefox/candidates/58.0-candidates/build8/update/mac/:lang/firefox-57.0.2-58.0.partial.mar
13:17:04 INFO - win32 (win): /firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-57.0.2-58.0.partial.mar
13:17:04 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-57.0.2-58.0.partial.mar', 'product': u'Firefox-58.0build8-Partial-57.0.2build2', 'os': 'win'}), kwargs: {}, attempt #1
13:17:04 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-57.0.2-58.0.partial.mar&product=Firefox-58.0build8-Partial-57.0.2build2&os=win
13:17:04 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:05 INFO - Server response
13:17:05 INFO - /firefox/candidates/58.0-candidates/build8/update/win32/:lang/firefox-57.0.2-58.0.partial.mar
13:17:05 INFO - win64 (win64): /firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-57.0.2-58.0.partial.mar
13:17:05 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-57.0.2-58.0.partial.mar', 'product': u'Firefox-58.0build8-Partial-57.0.2build2', 'os': 'win64'}), kwargs: {}, attempt #1
13:17:05 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F58.0-candidates%2Fbuild8%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-57.0.2-58.0.partial.mar&product=Firefox-58.0build8-Partial-57.0.2build2&os=win64
13:17:05 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:05 INFO - Server response
13:17:05 INFO - /firefox/candidates/58.0-candidates/build8/update/win64/:lang/firefox-57.0.2-58.0.partial.mar
13:17:05 INFO - Checking if Firefox-58.0-Partial-58.0b13 already exists
13:17:05 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-58.0-Partial-58.0b13', None), kwargs: {}, attempt #1
13:17:05 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-58.0-Partial-58.0b13
13:17:06 INFO - Server response
13:17:06 INFO -
13:17:06 INFO - Products found: 0
13:17:06 INFO - Adding partial updates for Firefox-58.0-Partial-58.0b13
13:17:06 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'zh-TW'], 'product': u'Firefox-58.0-Partial-58.0b13'}), kwargs: {}, attempt #1
13:17:06 INFO - POST data: languages=de&languages=en-US&languages=zh-TW&product=Firefox-58.0-Partial-58.0b13
13:17:06 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
13:17:06 INFO - Server response
13:17:06 INFO -
13:17:06 INFO - linux (linux): /firefox/releases/58.0/update/linux-i686/:lang/firefox-58.0b13-58.0.partial.mar
13:17:06 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/58.0/update/linux-i686/:lang/firefox-58.0b13-58.0.partial.mar', 'product': u'Firefox-58.0-Partial-58.0b13', 'os': 'linux'}), kwargs: {}, attempt #1
13:17:06 INFO - POST data: path=%2Ffirefox%2Freleases%2F58.0%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-58.0b13-58.0.partial.mar&product=Firefox-58.0-Partial-58.0b13&os=linux
13:17:06 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:07 INFO - Server response
13:17:07 INFO - /firefox/releases/58.0/update/linux-i686/:lang/firefox-58.0b13-58.0.partial.mar
13:17:07 INFO - linux64 (linux64): /firefox/releases/58.0/update/linux-x86_64/:lang/firefox-58.0b13-58.0.partial.mar
13:17:07 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/58.0/update/linux-x86_64/:lang/firefox-58.0b13-58.0.partial.mar', 'product': u'Firefox-58.0-Partial-58.0b13', 'os': 'linux64'}), kwargs: {}, attempt #1
13:17:07 INFO - POST data: path=%2Ffirefox%2Freleases%2F58.0%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-58.0b13-58.0.partial.mar&product=Firefox-58.0-Partial-58.0b13&os=linux64
13:17:07 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:08 INFO - Server response
13:17:08 INFO - /firefox/releases/58.0/update/linux-x86_64/:lang/firefox-58.0b13-58.0.partial.mar
13:17:08 INFO - macosx64 (osx): /firefox/releases/58.0/update/mac/:lang/firefox-58.0b13-58.0.partial.mar
13:17:08 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/58.0/update/mac/:lang/firefox-58.0b13-58.0.partial.mar', 'product': u'Firefox-58.0-Partial-58.0b13', 'os': 'osx'}), kwargs: {}, attempt #1
13:17:08 INFO - POST data: path=%2Ffirefox%2Freleases%2F58.0%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-58.0b13-58.0.partial.mar&product=Firefox-58.0-Partial-58.0b13&os=osx
13:17:08 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:08 INFO - Server response
13:17:08 INFO - /firefox/releases/58.0/update/mac/:lang/firefox-58.0b13-58.0.partial.mar
13:17:08 INFO - win32 (win): /firefox/releases/58.0/update/win32/:lang/firefox-58.0b13-58.0.partial.mar
13:17:08 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/58.0/update/win32/:lang/firefox-58.0b13-58.0.partial.mar', 'product': u'Firefox-58.0-Partial-58.0b13', 'os': 'win'}), kwargs: {}, attempt #1
13:17:08 INFO - POST data: path=%2Ffirefox%2Freleases%2F58.0%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-58.0b13-58.0.partial.mar&product=Firefox-58.0-Partial-58.0b13&os=win
13:17:08 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:09 INFO - Server response
13:17:09 INFO - /firefox/releases/58.0/update/win32/:lang/firefox-58.0b13-58.0.partial.mar
13:17:09 INFO - win64 (win64): /firefox/releases/58.0/update/win64/:lang/firefox-58.0b13-58.0.partial.mar
13:17:09 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/58.0/update/win64/:lang/firefox-58.0b13-58.0.partial.mar', 'product': u'Firefox-58.0-Partial-58.0b13', 'os': 'win64'}), kwargs: {}, attempt #1
13:17:09 INFO - POST data: path=%2Ffirefox%2Freleases%2F58.0%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-58.0b13-58.0.partial.mar&product=Firefox-58.0-Partial-58.0b13&os=win64
13:17:09 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
13:17:09 INFO - Server response
13:17:09 INFO - /firefox/releases/58.0/update/win64/:lang/firefox-58.0b13-58.0.partial.mar
13:17:09 INFO - Checking if Firefox-58.0-Partial-57.0.2 already exists
13:17:09 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-58.0-Partial-57.0.2', None), kwargs: {}, attempt #1
13:17:09 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-58.0-Partial-57.0.2
13:17:10 INFO - Server response
13:17:10 INFO -
13:17:10 INFO - Products found: 1
13:17:10 WARNING - Product Firefox-58.0-Partial-57.0.2 already exists. Skipping...
13:17:10 INFO - [mozharness: 2018-01-05 21:17:10.659334Z] Finished submit step (success)
13:17:10 INFO - Running post-run listener: copy_logs_to_upload_dir
13:17:10 INFO - Copying logs to upload dir...
13:17:10 INFO - mkdir: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/upload/logs
13:17:10 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=27.550856
========= master_lag: 0.01 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 27 secs) (at 2018-01-05 13:17:10.680733) =========
========= Started no change (results: 0, elapsed: 0 secs) (at 2018-01-05 13:17:10.684148) =========
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.005429
========= master_lag: 0.05 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2018-01-05 13:17:10.740044) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-01-05 13:17:10.740355) =========
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.002775
========= master_lag: 0.04 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-01-05 13:17:10.787486) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2018-01-05 13:17:10.787888) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2018-01-05 13:17:10.788147) =========
========= Total master_lag: 0.17 =========