builder: release-birch_firefox_bncr_sub
slave: bld-linux64-spot-303
starttime: 1519233607.82
results: success (0)
revision: 8c458d0333bc53154e021af4c8e5ab3698a7a704

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:07.815738) =========
master: http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:07.816142) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:07.816429) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:07.874528) =========

========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:07.874821) =========
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-21 09:20:07--  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%  512K=0.02s

2018-02-21 09:20:08 (512 KB/s) - ‘archiver_client.py’ saved [12179/12179]

program finished with exit code 0
elapsedTime=0.227644
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:08.124562) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:08.124914) =========
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.003211
========= master_lag: 0.05 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:08.174032) =========

========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2018-02-21 09:20:08.174370) =========
bash -c 'python archiver_client.py mozharness --repo projects/birch --rev 8c458d0333bc53154e021af4c8e5ab3698a7a704 --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 8c458d0333bc53154e021af4c8e5ab3698a7a704 --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-21 09:20:08,233 truncating revision to first 12 chars
2018-02-21 09:20:08,233 Setting DEBUG logging.
2018-02-21 09:20:08,233 attempt 1/10
2018-02-21 09:20:08,233 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/birch/8c458d0333bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2018-02-21 09:20:08,975 attempt 1/10
2018-02-21 09:20:09,733 current task status: no status available at this point. state: STARTED
2018-02-21 09:20:09,734 sleeping for 10.00s (attempt 1/10)
2018-02-21 09:20:19,744 attempt 2/10
2018-02-21 09:20:20,275 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS
2018-02-21 09:20:20,339 unpacking tar archive at: birch-8c458d0333bc/testing/mozharness/
program finished with exit code 0
elapsedTime=12.321115
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2018-02-21 09:20:20.508424) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:20.508769) =========
script_repo_revision: 8c458d0333bc53154e021af4c8e5ab3698a7a704
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:20.509154) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:20.509429) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:20.519108) =========

========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 17 secs) (at 2018-02-21 09:20:20.519383) =========
/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
09:20:20     INFO - MultiFileLogger online at 20180221 09:20:20 in /builds/slave/rel-bir_fx_bncr_sub-0000000000
09:20:20     INFO - Using buildbot properties:
09:20:20     INFO - {
09:20:20     INFO -     "project": "", 
09:20:20     INFO -     "product": "firefox", 
09:20:20     INFO -     "build_number": 16, 
09:20:20     INFO -     "taskId": "TrKdTh_fRS-TpBpTdABUpQ", 
09:20:20     INFO -     "repository": "https://hg.mozilla.org/projects/birch", 
09:20:20     INFO -     "buildername": "release-birch_firefox_bncr_sub", 
09:20:20     INFO -     "balrog_api_root": "https://balrog-admin.stage.mozaws.net/api", 
09:20:20     INFO -     "basedir": "/builds/slave/rel-bir_fx_bncr_sub-0000000000", 
09:20:20     INFO -     "appVersion": "61.0", 
09:20:20     INFO -     "buildnumber": 21, 
09:20:20     INFO -     "slavename": "bld-linux64-spot-303", 
09:20:20     INFO -     "version": "61.0", 
09:20:20     INFO -     "release_promotion": true, 
09:20:20     INFO -     "platform": null, 
09:20:20     INFO -     "branch": "birch", 
09:20:20     INFO -     "script_repo_revision": "8c458d0333bc53154e021af4c8e5ab3698a7a704", 
09:20:20     INFO -     "master": "http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/", 
09:20:20     INFO -     "revision": "8c458d0333bc53154e021af4c8e5ab3698a7a704", 
09:20:20     INFO -     "partial_versions": "58.0b13build1, 57.0build4", 
09:20:20     INFO -     "next_version": "61.0.1", 
09:20:20     INFO -     "repo_path": "projects/birch"
09:20:20     INFO - }
09:20:20     INFO - Overriding product with firefox
09:20:20     INFO - Overriding version with 61.0
09:20:20     INFO - Overriding build_number with 16
09:20:20     INFO - Overriding revision with 8c458d0333bc53154e021af4c8e5ab3698a7a704
09:20:20     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
09:20:20     INFO - Dumping config to /builds/slave/rel-bir_fx_bncr_sub-0000000000/logs/localconfig.json.
09:20:20     INFO - {'append_to_log': False,
09:20:20     INFO -  'base_work_dir': '/builds/slave/rel-bir_fx_bncr_sub-0000000000',
09:20:20     INFO -  'bouncer-api-prefix': 'https://admin-bouncer-releng.stage.mozaws.net/api',
09:20:20     INFO -  'bouncer_prefix': 'https://download.mozilla.org/',
09:20:20     INFO -  'build_number': 16,
09:20:20     INFO -  'buildbot_json_path': 'buildprops.json',
09:20:20     INFO -  'config_files': ('releases/bouncer_firefox_release.py',),
09:20:20     INFO -  'credentials_file': 'oauth.txt',
09:20:20     INFO -  'log_level': 'info',
09:20:20     INFO -  'log_to_console': True,
09:20:20     INFO -  'opt_config_files': (),
09:20:20     INFO -  'partials': {'candidates-dir': {'add-locales': True,
09:20:20     INFO -                                  'check_uptake': False,
09:20:20     INFO -                                  'paths': {'linux': {'bouncer-platform': 'linux',
09:20:20     INFO -                                                      'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
09:20:20     INFO -                                            'linux64': {'bouncer-platform': 'linux64',
09:20:20     INFO -                                                        'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
09:20:20     INFO -                                            'macosx64': {'bouncer-platform': 'osx',
09:20:20     INFO -                                                         'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
09:20:20     INFO -                                            'win32': {'bouncer-platform': 'win',
09:20:20     INFO -                                                      'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
09:20:20     INFO -                                            'win64': {'bouncer-platform': 'win64',
09:20:20     INFO -                                                      'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
09:20:20     INFO -                                  'product-name': 'Firefox-%(version)sbuild%(build_number)s-Partial-%(prev_version)sbuild%(prev_build_number)s',
09:20:20     INFO -                                  'ssl-only': False},
09:20:20     INFO -               'releases-dir': {'add-locales': True,
09:20:20     INFO -                                'check_uptake': True,
09:20:20     INFO -                                'paths': {'linux': {'bouncer-platform': 'linux',
09:20:20     INFO -                                                    'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
09:20:20     INFO -                                          'linux64': {'bouncer-platform': 'linux64',
09:20:20     INFO -                                                      'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
09:20:20     INFO -                                          'macosx64': {'bouncer-platform': 'osx',
09:20:20     INFO -                                                       'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
09:20:20     INFO -                                          'win32': {'bouncer-platform': 'win',
09:20:20     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
09:20:20     INFO -                                          'win64': {'bouncer-platform': 'win64',
09:20:20     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
09:20:20     INFO -                                'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s',
09:20:20     INFO -                                'ssl-only': False}},
09:20:20     INFO -  'prev_versions': (u'58.0b13build1', u'57.0build4'),
09:20:20     INFO -  'product': u'firefox',
09:20:20     INFO -  'products': {'complete-mar': {'add-locales': True,
09:20:20     INFO -                                'check_uptake': True,
09:20:20     INFO -                                'paths': {'linux': {'bouncer-platform': 'linux',
09:20:20     INFO -                                                    'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
09:20:20     INFO -                                          'linux64': {'bouncer-platform': 'linux64',
09:20:20     INFO -                                                      'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
09:20:20     INFO -                                          'macosx64': {'bouncer-platform': 'osx',
09:20:20     INFO -                                                       'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
09:20:20     INFO -                                          'win32': {'bouncer-platform': 'win',
09:20:20     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
09:20:20     INFO -                                          'win64': {'bouncer-platform': 'win64',
09:20:20     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
09:20:20     INFO -                                'product-name': 'Firefox-%(version)s-Complete',
09:20:20     INFO -                                'ssl-only': False},
09:20:20     INFO -               'complete-mar-candidates': {'add-locales': True,
09:20:20     INFO -                                           'check_uptake': False,
09:20:20     INFO -                                           'paths': {'linux': {'bouncer-platform': 'linux',
09:20:20     INFO -                                                               'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
09:20:20     INFO -                                                     'linux64': {'bouncer-platform': 'linux64',
09:20:20     INFO -                                                                 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
09:20:20     INFO -                                                     'macosx64': {'bouncer-platform': 'osx',
09:20:20     INFO -                                                                  'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
09:20:20     INFO -                                                     'win32': {'bouncer-platform': 'win',
09:20:20     INFO -                                                               'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
09:20:20     INFO -                                                     'win64': {'bouncer-platform': 'win64',
09:20:20     INFO -                                                               'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
09:20:20     INFO -                                           'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete',
09:20:20     INFO -                                           'ssl-only': False},
09:20:20     INFO -               'installer': {'add-locales': True,
09:20:20     INFO -                             'alias': 'firefox-latest',
09:20:20     INFO -                             'check_uptake': True,
09:20:20     INFO -                             'paths': {'linux': {'bouncer-platform': 'linux',
09:20:20     INFO -                                                 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
09:20:20     INFO -                                       'linux64': {'bouncer-platform': 'linux64',
09:20:20     INFO -                                                   'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
09:20:20     INFO -                                       'macosx64': {'bouncer-platform': 'osx',
09:20:20     INFO -                                                    'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
09:20:20     INFO -                                       'win32': {'bouncer-platform': 'win',
09:20:20     INFO -                                                 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
09:20:20     INFO -                                       'win64': {'bouncer-platform': 'win64',
09:20:20     INFO -                                                 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
09:20:20     INFO -                             'product-name': 'Firefox-%(version)s',
09:20:20     INFO -                             'ssl-only': False},
09:20:20     INFO -               'installer-ssl': {'add-locales': True,
09:20:20     INFO -                                 'alias': 'firefox-latest-ssl',
09:20:20     INFO -                                 'check_uptake': True,
09:20:20     INFO -                                 'paths': {'linux': {'bouncer-platform': 'linux',
09:20:20     INFO -                                                     'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
09:20:20     INFO -                                           'linux64': {'bouncer-platform': 'linux64',
09:20:20     INFO -                                                       'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
09:20:20     INFO -                                           'macosx64': {'bouncer-platform': 'osx',
09:20:20     INFO -                                                        'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
09:20:20     INFO -                                           'win32': {'bouncer-platform': 'win',
09:20:20     INFO -                                                     'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
09:20:20     INFO -                                           'win64': {'bouncer-platform': 'win64',
09:20:20     INFO -                                                     'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
09:20:20     INFO -                                 'product-name': 'Firefox-%(version)s-SSL',
09:20:20     INFO -                                 'ssl-only': True},
09:20:20     INFO -               'stub-installer': {'add-locales': True,
09:20:20     INFO -                                  'alias': 'firefox-stub',
09:20:20     INFO -                                  'check_uptake': True,
09:20:20     INFO -                                  'paths': {'win32': {'bouncer-platform': 'win',
09:20:20     INFO -                                                      'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'},
09:20:20     INFO -                                            'win64': {'bouncer-platform': 'win64',
09:20:20     INFO -                                                      'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}},
09:20:20     INFO -                                  'product-name': 'Firefox-%(version)s-stub',
09:20:20     INFO -                                  'ssl-only': True}},
09:20:20     INFO -  'repo': 'projects/birch',
09:20:20     INFO -  'revision': u'8c458d0333bc53154e021af4c8e5ab3698a7a704',
09:20:20     INFO -  'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales',
09:20:20     INFO -  'version': u'61.0',
09:20:20     INFO -  'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
09:20:20     INFO -  'work_dir': 'build'}
09:20:20     INFO - [mozharness: 2018-02-21 17:20:20.697066Z] Running clobber step.
09:20:20     INFO - Running main action method: clobber
09:20:20     INFO - rmtree: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build
09:20:20     INFO - [mozharness: 2018-02-21 17:20:20.700371Z] Finished clobber step (success)
09:20:20     INFO - [mozharness: 2018-02-21 17:20:20.700674Z] Running download-shipped-locales step.
09:20:20     INFO - Running main action method: download_shipped_locales
09:20:20     INFO - mkdir: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build
09:20:20     INFO - Downloading https://hg.mozilla.org/projects/birch/raw-file/8c458d0333bc53154e021af4c8e5ab3698a7a704/browser/locales/shipped-locales to /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales
09:20:20     INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://hg.mozilla.org/projects/birch/raw-file/8c458d0333bc53154e021af4c8e5ab3698a7a704/browser/locales/shipped-locales', 'file_name': '/builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales'}, attempt #1
09:20:21     INFO - Downloaded 18 bytes.
09:20:21     INFO - Reading from file /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales
09:20:21     INFO - Contents:
09:20:21     INFO -  de
09:20:21     INFO -  en-US
09:20:21     INFO -  ru
09:20:21     INFO -  zh-TW
09:20:21     INFO - [mozharness: 2018-02-21 17:20:21.640048Z] Finished download-shipped-locales step (success)
09:20:21     INFO - [mozharness: 2018-02-21 17:20:21.640271Z] Running submit step.
09:20:21     INFO - Running main action method: submit
09:20:21     INFO - Checking if Firefox-61.0-Complete already exists
09:20:21     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-Complete', None), kwargs: {}, attempt #1
09:20:21     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-Complete
09:20:22     INFO - Server response
09:20:22     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8379" name="Firefox-61.0-Complete"><language locale="ach"/><language locale="af"/><language locale="an"/><language locale="ar"/><language locale="as"/><language locale="ast"/><language locale="az"/><language locale="be"/><language locale="bg"/><language locale="bn-BD"/><language locale="bn-IN"/><language locale="br"/><language locale="bs"/><language locale="ca"/><language locale="cak"/><language locale="cs"/><language locale="cy"/><language locale="da"/><language locale="de"/><language locale="dsb"/><language locale="el"/><language locale="en-GB"/><language locale="en-US"/><language locale="en-ZA"/><language locale="eo"/><language locale="es-AR"/><language locale="es-CL"/><language locale="es-ES"/><language locale="es-MX"/><language locale="et"/><language locale="eu"/><language locale="fa"/><language locale="ff"/><language locale="fi"/><language locale="fr"/><language locale="fy-NL"/><language locale="ga-IE"/><language locale="gd"/><language locale="gl"/><language locale="gn"/><language locale="gu-IN"/><language locale="he"/><language locale="hi-IN"/><language locale="hr"/><language locale="hsb"/><language locale="hu"/><language locale="hy-AM"/><language locale="ia"/><language locale="id"/><language locale="is"/><language locale="it"/><language locale="ja"/><language locale="ja-JP-mac"/><language locale="ka"/><language locale="kab"/><language locale="kk"/><language locale="km"/><language locale="kn"/><language locale="ko"/><language locale="lij"/><language locale="lt"/><language locale="lv"/><language locale="mai"/><language locale="mk"/><language locale="ml"/><language locale="mr"/><language locale="ms"/><language locale="my"/><language locale="nb-NO"/><language locale="ne-NP"/><language locale="nl"/><language locale="nn-NO"/><language locale="or"/><language locale="pa-IN"/><language locale="pl"/><language locale="pt-BR"/><language locale="pt-PT"/><language locale="rm"/><language locale="ro"/><language locale="ru"/><language locale="si"/><language locale="sk"/><language locale="sl"/><language locale="son"/><language locale="sq"/><language locale="sr"/><language locale="sv-SE"/><language locale="ta"/><language locale="te"/><language locale="th"/><language locale="tr"/><language locale="uk"/><language locale="ur"/><language locale="uz"/><language locale="vi"/><language locale="xh"/><language locale="zh-CN"/><language locale="zh-TW"/></product></products>
09:20:22     INFO - Products found: 1
09:20:22  WARNING - Product Firefox-61.0-Complete already exists. Skipping...
09:20:22     INFO - Checking if Firefox-61.0build16-Complete already exists
09:20:22     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0build16-Complete', None), kwargs: {}, attempt #1
09:20:22     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0build16-Complete
09:20:22     INFO - Server response
09:20:22     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
09:20:22     INFO - Products found: 0
09:20:22     INFO - Adding complete-mar-candidates...
09:20:22     INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'ru', 'zh-TW'], 'product': u'Firefox-61.0build16-Complete'}), kwargs: {}, attempt #1
09:20:22     INFO - POST data: languages=de&languages=en-US&languages=ru&languages=zh-TW&product=Firefox-61.0build16-Complete
09:20:22     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
09:20:23     INFO - Server response
09:20:23     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8482" name="Firefox-61.0build16-Complete"><language locale="de"/><language locale="en-US"/><language locale="ru"/><language locale="zh-TW"/></product></products>
09:20:23     INFO - Adding paths...
09:20:23     INFO - linux (linux): /firefox/candidates/61.0-candidates/build16/update/linux-i686/:lang/firefox-61.0.complete.mar
09:20:23     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/linux-i686/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build16-Complete', 'os': 'linux'}), kwargs: {}, attempt #1
09:20:23     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build16-Complete&os=linux
09:20:23     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:24     INFO - Server response
09:20:24     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8482" name="Firefox-61.0build16-Complete"><location id="42657" os="linux">/firefox/candidates/61.0-candidates/build16/update/linux-i686/:lang/firefox-61.0.complete.mar</location></product></locations>
09:20:24     INFO - linux64 (linux64): /firefox/candidates/61.0-candidates/build16/update/linux-x86_64/:lang/firefox-61.0.complete.mar
09:20:24     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/linux-x86_64/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build16-Complete', 'os': 'linux64'}), kwargs: {}, attempt #1
09:20:24     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build16-Complete&os=linux64
09:20:24     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:24     INFO - Server response
09:20:24     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8482" name="Firefox-61.0build16-Complete"><location id="42658" os="linux64">/firefox/candidates/61.0-candidates/build16/update/linux-x86_64/:lang/firefox-61.0.complete.mar</location></product></locations>
09:20:24     INFO - macosx64 (osx): /firefox/candidates/61.0-candidates/build16/update/mac/:lang/firefox-61.0.complete.mar
09:20:24     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/mac/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build16-Complete', 'os': 'osx'}), kwargs: {}, attempt #1
09:20:24     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build16-Complete&os=osx
09:20:24     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:25     INFO - Server response
09:20:25     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8482" name="Firefox-61.0build16-Complete"><location id="42659" os="osx">/firefox/candidates/61.0-candidates/build16/update/mac/:lang/firefox-61.0.complete.mar</location></product></locations>
09:20:25     INFO - win32 (win): /firefox/candidates/61.0-candidates/build16/update/win32/:lang/firefox-61.0.complete.mar
09:20:25     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/win32/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build16-Complete', 'os': 'win'}), kwargs: {}, attempt #1
09:20:25     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build16-Complete&os=win
09:20:25     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:26     INFO - Server response
09:20:26     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8482" name="Firefox-61.0build16-Complete"><location id="42660" os="win">/firefox/candidates/61.0-candidates/build16/update/win32/:lang/firefox-61.0.complete.mar</location></product></locations>
09:20:26     INFO - win64 (win64): /firefox/candidates/61.0-candidates/build16/update/win64/:lang/firefox-61.0.complete.mar
09:20:26     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/win64/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build16-Complete', 'os': 'win64'}), kwargs: {}, attempt #1
09:20:26     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build16-Complete&os=win64
09:20:26     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:26     INFO - Server response
09:20:26     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8482" name="Firefox-61.0build16-Complete"><location id="42661" os="win64">/firefox/candidates/61.0-candidates/build16/update/win64/:lang/firefox-61.0.complete.mar</location></product></locations>
09:20:26     INFO - Checking if Firefox-61.0 already exists
09:20:26     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0', None), kwargs: {}, attempt #1
09:20:26     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0
09:20:27     INFO - Server response
09:20:27     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8381" name="Firefox-61.0"><language locale="ach"/><language locale="af"/><language locale="an"/><language locale="ar"/><language locale="as"/><language locale="ast"/><language locale="az"/><language locale="be"/><language locale="bg"/><language locale="bn-BD"/><language locale="bn-IN"/><language locale="br"/><language locale="bs"/><language locale="ca"/><language locale="cak"/><language locale="cs"/><language locale="cy"/><language locale="da"/><language locale="de"/><language locale="dsb"/><language locale="el"/><language locale="en-GB"/><language locale="en-US"/><language locale="en-ZA"/><language locale="eo"/><language locale="es-AR"/><language locale="es-CL"/><language locale="es-ES"/><language locale="es-MX"/><language locale="et"/><language locale="eu"/><language locale="fa"/><language locale="ff"/><language locale="fi"/><language locale="fr"/><language locale="fy-NL"/><language locale="ga-IE"/><language locale="gd"/><language locale="gl"/><language locale="gn"/><language locale="gu-IN"/><language locale="he"/><language locale="hi-IN"/><language locale="hr"/><language locale="hsb"/><language locale="hu"/><language locale="hy-AM"/><language locale="ia"/><language locale="id"/><language locale="is"/><language locale="it"/><language locale="ja"/><language locale="ja-JP-mac"/><language locale="ka"/><language locale="kab"/><language locale="kk"/><language locale="km"/><language locale="kn"/><language locale="ko"/><language locale="lij"/><language locale="lt"/><language locale="lv"/><language locale="mai"/><language locale="mk"/><language locale="ml"/><language locale="mr"/><language locale="ms"/><language locale="my"/><language locale="nb-NO"/><language locale="ne-NP"/><language locale="nl"/><language locale="nn-NO"/><language locale="or"/><language locale="pa-IN"/><language locale="pl"/><language locale="pt-BR"/><language locale="pt-PT"/><language locale="rm"/><language locale="ro"/><language locale="ru"/><language locale="si"/><language locale="sk"/><language locale="sl"/><language locale="son"/><language locale="sq"/><language locale="sr"/><language locale="sv-SE"/><language locale="ta"/><language locale="te"/><language locale="th"/><language locale="tr"/><language locale="uk"/><language locale="ur"/><language locale="uz"/><language locale="vi"/><language locale="xh"/><language locale="zh-CN"/><language locale="zh-TW"/></product></products>
09:20:27     INFO - Products found: 1
09:20:27  WARNING - Product Firefox-61.0 already exists. Skipping...
09:20:27     INFO - Checking if Firefox-61.0-SSL already exists
09:20:27     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-SSL', None), kwargs: {}, attempt #1
09:20:27     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-SSL
09:20:27     INFO - Server response
09:20:27     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8382" name="Firefox-61.0-SSL"><language locale="ach"/><language locale="af"/><language locale="an"/><language locale="ar"/><language locale="as"/><language locale="ast"/><language locale="az"/><language locale="be"/><language locale="bg"/><language locale="bn-BD"/><language locale="bn-IN"/><language locale="br"/><language locale="bs"/><language locale="ca"/><language locale="cak"/><language locale="cs"/><language locale="cy"/><language locale="da"/><language locale="de"/><language locale="dsb"/><language locale="el"/><language locale="en-GB"/><language locale="en-US"/><language locale="en-ZA"/><language locale="eo"/><language locale="es-AR"/><language locale="es-CL"/><language locale="es-ES"/><language locale="es-MX"/><language locale="et"/><language locale="eu"/><language locale="fa"/><language locale="ff"/><language locale="fi"/><language locale="fr"/><language locale="fy-NL"/><language locale="ga-IE"/><language locale="gd"/><language locale="gl"/><language locale="gn"/><language locale="gu-IN"/><language locale="he"/><language locale="hi-IN"/><language locale="hr"/><language locale="hsb"/><language locale="hu"/><language locale="hy-AM"/><language locale="ia"/><language locale="id"/><language locale="is"/><language locale="it"/><language locale="ja"/><language locale="ja-JP-mac"/><language locale="ka"/><language locale="kab"/><language locale="kk"/><language locale="km"/><language locale="kn"/><language locale="ko"/><language locale="lij"/><language locale="lt"/><language locale="lv"/><language locale="mai"/><language locale="mk"/><language locale="ml"/><language locale="mr"/><language locale="ms"/><language locale="my"/><language locale="nb-NO"/><language locale="ne-NP"/><language locale="nl"/><language locale="nn-NO"/><language locale="or"/><language locale="pa-IN"/><language locale="pl"/><language locale="pt-BR"/><language locale="pt-PT"/><language locale="rm"/><language locale="ro"/><language locale="ru"/><language locale="si"/><language locale="sk"/><language locale="sl"/><language locale="son"/><language locale="sq"/><language locale="sr"/><language locale="sv-SE"/><language locale="ta"/><language locale="te"/><language locale="th"/><language locale="tr"/><language locale="uk"/><language locale="ur"/><language locale="uz"/><language locale="vi"/><language locale="xh"/><language locale="zh-CN"/><language locale="zh-TW"/></product></products>
09:20:27     INFO - Products found: 1
09:20:27  WARNING - Product Firefox-61.0-SSL already exists. Skipping...
09:20:27     INFO - Checking if Firefox-61.0-stub already exists
09:20:27     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-stub', None), kwargs: {}, attempt #1
09:20:27     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-stub
09:20:28     INFO - Server response
09:20:28     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8383" name="Firefox-61.0-stub"><language locale="ach"/><language locale="af"/><language locale="an"/><language locale="ar"/><language locale="as"/><language locale="ast"/><language locale="az"/><language locale="be"/><language locale="bg"/><language locale="bn-BD"/><language locale="bn-IN"/><language locale="br"/><language locale="bs"/><language locale="ca"/><language locale="cak"/><language locale="cs"/><language locale="cy"/><language locale="da"/><language locale="de"/><language locale="dsb"/><language locale="el"/><language locale="en-GB"/><language locale="en-US"/><language locale="en-ZA"/><language locale="eo"/><language locale="es-AR"/><language locale="es-CL"/><language locale="es-ES"/><language locale="es-MX"/><language locale="et"/><language locale="eu"/><language locale="fa"/><language locale="ff"/><language locale="fi"/><language locale="fr"/><language locale="fy-NL"/><language locale="ga-IE"/><language locale="gd"/><language locale="gl"/><language locale="gn"/><language locale="gu-IN"/><language locale="he"/><language locale="hi-IN"/><language locale="hr"/><language locale="hsb"/><language locale="hu"/><language locale="hy-AM"/><language locale="ia"/><language locale="id"/><language locale="is"/><language locale="it"/><language locale="ja"/><language locale="ja-JP-mac"/><language locale="ka"/><language locale="kab"/><language locale="kk"/><language locale="km"/><language locale="kn"/><language locale="ko"/><language locale="lij"/><language locale="lt"/><language locale="lv"/><language locale="mai"/><language locale="mk"/><language locale="ml"/><language locale="mr"/><language locale="ms"/><language locale="my"/><language locale="nb-NO"/><language locale="ne-NP"/><language locale="nl"/><language locale="nn-NO"/><language locale="or"/><language locale="pa-IN"/><language locale="pl"/><language locale="pt-BR"/><language locale="pt-PT"/><language locale="rm"/><language locale="ro"/><language locale="ru"/><language locale="si"/><language locale="sk"/><language locale="sl"/><language locale="son"/><language locale="sq"/><language locale="sr"/><language locale="sv-SE"/><language locale="ta"/><language locale="te"/><language locale="th"/><language locale="tr"/><language locale="uk"/><language locale="ur"/><language locale="uz"/><language locale="vi"/><language locale="xh"/><language locale="zh-CN"/><language locale="zh-TW"/></product></products>
09:20:28     INFO - Products found: 1
09:20:28  WARNING - Product Firefox-61.0-stub already exists. Skipping...
09:20:28     INFO - Checking if Firefox-61.0build16-Partial-58.0b13build1 already exists
09:20:28     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0build16-Partial-58.0b13build1', None), kwargs: {}, attempt #1
09:20:28     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0build16-Partial-58.0b13build1
09:20:28     INFO - Server response
09:20:28     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
09:20:28     INFO - Products found: 0
09:20:28     INFO - Adding partial updates for Firefox-61.0build16-Partial-58.0b13build1
09:20:28     INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'ru', 'zh-TW'], 'product': u'Firefox-61.0build16-Partial-58.0b13build1'}), kwargs: {}, attempt #1
09:20:28     INFO - POST data: languages=de&languages=en-US&languages=ru&languages=zh-TW&product=Firefox-61.0build16-Partial-58.0b13build1
09:20:28     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
09:20:29     INFO - Server response
09:20:29     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8483" name="Firefox-61.0build16-Partial-58.0b13build1"><language locale="de"/><language locale="en-US"/><language locale="ru"/><language locale="zh-TW"/></product></products>
09:20:29     INFO - linux (linux): /firefox/candidates/61.0-candidates/build16/update/linux-i686/:lang/firefox-58.0b13-61.0.partial.mar
09:20:29     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/linux-i686/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build16-Partial-58.0b13build1', 'os': 'linux'}), kwargs: {}, attempt #1
09:20:29     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build16-Partial-58.0b13build1&os=linux
09:20:29     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:30     INFO - Server response
09:20:30     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8483" name="Firefox-61.0build16-Partial-58.0b13build1"><location id="42662" os="linux">/firefox/candidates/61.0-candidates/build16/update/linux-i686/:lang/firefox-58.0b13-61.0.partial.mar</location></product></locations>
09:20:30     INFO - linux64 (linux64): /firefox/candidates/61.0-candidates/build16/update/linux-x86_64/:lang/firefox-58.0b13-61.0.partial.mar
09:20:30     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/linux-x86_64/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build16-Partial-58.0b13build1', 'os': 'linux64'}), kwargs: {}, attempt #1
09:20:30     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build16-Partial-58.0b13build1&os=linux64
09:20:30     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:30     INFO - Server response
09:20:30     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8483" name="Firefox-61.0build16-Partial-58.0b13build1"><location id="42663" os="linux64">/firefox/candidates/61.0-candidates/build16/update/linux-x86_64/:lang/firefox-58.0b13-61.0.partial.mar</location></product></locations>
09:20:30     INFO - macosx64 (osx): /firefox/candidates/61.0-candidates/build16/update/mac/:lang/firefox-58.0b13-61.0.partial.mar
09:20:30     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/mac/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build16-Partial-58.0b13build1', 'os': 'osx'}), kwargs: {}, attempt #1
09:20:30     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build16-Partial-58.0b13build1&os=osx
09:20:30     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:31     INFO - Server response
09:20:31     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8483" name="Firefox-61.0build16-Partial-58.0b13build1"><location id="42664" os="osx">/firefox/candidates/61.0-candidates/build16/update/mac/:lang/firefox-58.0b13-61.0.partial.mar</location></product></locations>
09:20:31     INFO - win32 (win): /firefox/candidates/61.0-candidates/build16/update/win32/:lang/firefox-58.0b13-61.0.partial.mar
09:20:31     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/win32/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build16-Partial-58.0b13build1', 'os': 'win'}), kwargs: {}, attempt #1
09:20:31     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build16-Partial-58.0b13build1&os=win
09:20:31     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:32     INFO - Server response
09:20:32     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8483" name="Firefox-61.0build16-Partial-58.0b13build1"><location id="42665" os="win">/firefox/candidates/61.0-candidates/build16/update/win32/:lang/firefox-58.0b13-61.0.partial.mar</location></product></locations>
09:20:32     INFO - win64 (win64): /firefox/candidates/61.0-candidates/build16/update/win64/:lang/firefox-58.0b13-61.0.partial.mar
09:20:32     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/win64/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build16-Partial-58.0b13build1', 'os': 'win64'}), kwargs: {}, attempt #1
09:20:32     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build16-Partial-58.0b13build1&os=win64
09:20:32     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:32     INFO - Server response
09:20:32     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8483" name="Firefox-61.0build16-Partial-58.0b13build1"><location id="42666" os="win64">/firefox/candidates/61.0-candidates/build16/update/win64/:lang/firefox-58.0b13-61.0.partial.mar</location></product></locations>
09:20:32     INFO - Checking if Firefox-61.0build16-Partial-57.0build4 already exists
09:20:32     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0build16-Partial-57.0build4', None), kwargs: {}, attempt #1
09:20:32     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0build16-Partial-57.0build4
09:20:33     INFO - Server response
09:20:33     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
09:20:33     INFO - Products found: 0
09:20:33     INFO - Adding partial updates for Firefox-61.0build16-Partial-57.0build4
09:20:33     INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'ru', 'zh-TW'], 'product': u'Firefox-61.0build16-Partial-57.0build4'}), kwargs: {}, attempt #1
09:20:33     INFO - POST data: languages=de&languages=en-US&languages=ru&languages=zh-TW&product=Firefox-61.0build16-Partial-57.0build4
09:20:33     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
09:20:34     INFO - Server response
09:20:34     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8484" name="Firefox-61.0build16-Partial-57.0build4"><language locale="de"/><language locale="en-US"/><language locale="ru"/><language locale="zh-TW"/></product></products>
09:20:34     INFO - linux (linux): /firefox/candidates/61.0-candidates/build16/update/linux-i686/:lang/firefox-57.0-61.0.partial.mar
09:20:34     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/linux-i686/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build16-Partial-57.0build4', 'os': 'linux'}), kwargs: {}, attempt #1
09:20:34     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build16-Partial-57.0build4&os=linux
09:20:34     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:34     INFO - Server response
09:20:34     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8484" name="Firefox-61.0build16-Partial-57.0build4"><location id="42667" os="linux">/firefox/candidates/61.0-candidates/build16/update/linux-i686/:lang/firefox-57.0-61.0.partial.mar</location></product></locations>
09:20:34     INFO - linux64 (linux64): /firefox/candidates/61.0-candidates/build16/update/linux-x86_64/:lang/firefox-57.0-61.0.partial.mar
09:20:34     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/linux-x86_64/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build16-Partial-57.0build4', 'os': 'linux64'}), kwargs: {}, attempt #1
09:20:34     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build16-Partial-57.0build4&os=linux64
09:20:34     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:35     INFO - Server response
09:20:35     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8484" name="Firefox-61.0build16-Partial-57.0build4"><location id="42668" os="linux64">/firefox/candidates/61.0-candidates/build16/update/linux-x86_64/:lang/firefox-57.0-61.0.partial.mar</location></product></locations>
09:20:35     INFO - macosx64 (osx): /firefox/candidates/61.0-candidates/build16/update/mac/:lang/firefox-57.0-61.0.partial.mar
09:20:35     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/mac/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build16-Partial-57.0build4', 'os': 'osx'}), kwargs: {}, attempt #1
09:20:35     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build16-Partial-57.0build4&os=osx
09:20:35     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:35     INFO - Server response
09:20:35     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8484" name="Firefox-61.0build16-Partial-57.0build4"><location id="42669" os="osx">/firefox/candidates/61.0-candidates/build16/update/mac/:lang/firefox-57.0-61.0.partial.mar</location></product></locations>
09:20:35     INFO - win32 (win): /firefox/candidates/61.0-candidates/build16/update/win32/:lang/firefox-57.0-61.0.partial.mar
09:20:35     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/win32/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build16-Partial-57.0build4', 'os': 'win'}), kwargs: {}, attempt #1
09:20:35     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build16-Partial-57.0build4&os=win
09:20:35     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:36     INFO - Server response
09:20:36     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8484" name="Firefox-61.0build16-Partial-57.0build4"><location id="42670" os="win">/firefox/candidates/61.0-candidates/build16/update/win32/:lang/firefox-57.0-61.0.partial.mar</location></product></locations>
09:20:36     INFO - win64 (win64): /firefox/candidates/61.0-candidates/build16/update/win64/:lang/firefox-57.0-61.0.partial.mar
09:20:36     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build16/update/win64/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build16-Partial-57.0build4', 'os': 'win64'}), kwargs: {}, attempt #1
09:20:36     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild16%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build16-Partial-57.0build4&os=win64
09:20:36     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
09:20:36     INFO - Server response
09:20:36     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8484" name="Firefox-61.0build16-Partial-57.0build4"><location id="42671" os="win64">/firefox/candidates/61.0-candidates/build16/update/win64/:lang/firefox-57.0-61.0.partial.mar</location></product></locations>
09:20:36     INFO - Checking if Firefox-61.0-Partial-58.0b13 already exists
09:20:36     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-Partial-58.0b13', None), kwargs: {}, attempt #1
09:20:36     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-Partial-58.0b13
09:20:37     INFO - Server response
09:20:37     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8420" name="Firefox-61.0-Partial-58.0b13"><language locale="ach"/><language locale="af"/><language locale="an"/><language locale="ar"/><language locale="as"/><language locale="ast"/><language locale="az"/><language locale="be"/><language locale="bg"/><language locale="bn-BD"/><language locale="bn-IN"/><language locale="br"/><language locale="bs"/><language locale="ca"/><language locale="cak"/><language locale="cs"/><language locale="cy"/><language locale="da"/><language locale="de"/><language locale="dsb"/><language locale="el"/><language locale="en-GB"/><language locale="en-US"/><language locale="en-ZA"/><language locale="eo"/><language locale="es-AR"/><language locale="es-CL"/><language locale="es-ES"/><language locale="es-MX"/><language locale="et"/><language locale="eu"/><language locale="fa"/><language locale="ff"/><language locale="fi"/><language locale="fr"/><language locale="fy-NL"/><language locale="ga-IE"/><language locale="gd"/><language locale="gl"/><language locale="gn"/><language locale="gu-IN"/><language locale="he"/><language locale="hi-IN"/><language locale="hr"/><language locale="hsb"/><language locale="hu"/><language locale="hy-AM"/><language locale="ia"/><language locale="id"/><language locale="is"/><language locale="it"/><language locale="ja"/><language locale="ja-JP-mac"/><language locale="ka"/><language locale="kab"/><language locale="kk"/><language locale="km"/><language locale="kn"/><language locale="ko"/><language locale="lij"/><language locale="lt"/><language locale="lv"/><language locale="mai"/><language locale="mk"/><language locale="ml"/><language locale="mr"/><language locale="ms"/><language locale="my"/><language locale="nb-NO"/><language locale="ne-NP"/><language locale="nl"/><language locale="nn-NO"/><language locale="or"/><language locale="pa-IN"/><language locale="pl"/><language locale="pt-BR"/><language locale="pt-PT"/><language locale="rm"/><language locale="ro"/><language locale="ru"/><language locale="si"/><language locale="sk"/><language locale="sl"/><language locale="son"/><language locale="sq"/><language locale="sr"/><language locale="sv-SE"/><language locale="ta"/><language locale="te"/><language locale="th"/><language locale="tr"/><language locale="uk"/><language locale="ur"/><language locale="uz"/><language locale="vi"/><language locale="xh"/><language locale="zh-CN"/><language locale="zh-TW"/></product></products>
09:20:37     INFO - Products found: 1
09:20:37  WARNING - Product Firefox-61.0-Partial-58.0b13 already exists. Skipping...
09:20:37     INFO - Checking if Firefox-61.0-Partial-57.0 already exists
09:20:37     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-Partial-57.0', None), kwargs: {}, attempt #1
09:20:37     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-Partial-57.0
09:20:38     INFO - Server response
09:20:38     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8385" name="Firefox-61.0-Partial-57.0"><language locale="ach"/><language locale="af"/><language locale="an"/><language locale="ar"/><language locale="as"/><language locale="ast"/><language locale="az"/><language locale="be"/><language locale="bg"/><language locale="bn-BD"/><language locale="bn-IN"/><language locale="br"/><language locale="bs"/><language locale="ca"/><language locale="cak"/><language locale="cs"/><language locale="cy"/><language locale="da"/><language locale="de"/><language locale="dsb"/><language locale="el"/><language locale="en-GB"/><language locale="en-US"/><language locale="en-ZA"/><language locale="eo"/><language locale="es-AR"/><language locale="es-CL"/><language locale="es-ES"/><language locale="es-MX"/><language locale="et"/><language locale="eu"/><language locale="fa"/><language locale="ff"/><language locale="fi"/><language locale="fr"/><language locale="fy-NL"/><language locale="ga-IE"/><language locale="gd"/><language locale="gl"/><language locale="gn"/><language locale="gu-IN"/><language locale="he"/><language locale="hi-IN"/><language locale="hr"/><language locale="hsb"/><language locale="hu"/><language locale="hy-AM"/><language locale="ia"/><language locale="id"/><language locale="is"/><language locale="it"/><language locale="ja"/><language locale="ja-JP-mac"/><language locale="ka"/><language locale="kab"/><language locale="kk"/><language locale="km"/><language locale="kn"/><language locale="ko"/><language locale="lij"/><language locale="lt"/><language locale="lv"/><language locale="mai"/><language locale="mk"/><language locale="ml"/><language locale="mr"/><language locale="ms"/><language locale="my"/><language locale="nb-NO"/><language locale="ne-NP"/><language locale="nl"/><language locale="nn-NO"/><language locale="or"/><language locale="pa-IN"/><language locale="pl"/><language locale="pt-BR"/><language locale="pt-PT"/><language locale="rm"/><language locale="ro"/><language locale="ru"/><language locale="si"/><language locale="sk"/><language locale="sl"/><language locale="son"/><language locale="sq"/><language locale="sr"/><language locale="sv-SE"/><language locale="ta"/><language locale="te"/><language locale="th"/><language locale="tr"/><language locale="uk"/><language locale="ur"/><language locale="uz"/><language locale="vi"/><language locale="xh"/><language locale="zh-CN"/><language locale="zh-TW"/></product></products>
09:20:38     INFO - Products found: 1
09:20:38  WARNING - Product Firefox-61.0-Partial-57.0 already exists. Skipping...
09:20:38     INFO - [mozharness: 2018-02-21 17:20:38.076152Z] Finished submit step (success)
09:20:38     INFO - Running post-run listener: copy_logs_to_upload_dir
09:20:38     INFO - Copying logs to upload dir...
09:20:38     INFO - mkdir: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/upload/logs
09:20:38     INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=17.558458
========= master_lag: 0.02 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 17 secs) (at 2018-02-21 09:20:38.100498) =========

========= Started no change (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:38.103233) =========
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.005560

========= master_lag: 0.04 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:38.153533) =========

========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:38.153843) =========
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.003305
========= master_lag: 0.05 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-02-21 09:20:38.202944) =========

========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2018-02-21 09:20:38.203225) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2018-02-21 09:20:38.203460) =========

========= Total master_lag: 0.19 =========