builder: release-birch_firefox_bncr_sub
slave: bld-linux64-spot-324
starttime: 1518621911.83
results: success (0)
revision: e7dd761c5ba89c16d566b4ce1544526d8a6395c2

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:11.825744) =========
master: http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:11.837530) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:11.837836) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:11.894535) =========

========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:11.894832) =========
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-324.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-14 07:25:12--  https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: ‘archiver_client.py’

     0K .......... .                                          100% 81.1M=0s

2018-02-14 07:25:12 (81.1 MB/s) - ‘archiver_client.py’ saved [12179/12179]

program finished with exit code 0
elapsedTime=0.513825
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:12.420422) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:12.420778) =========
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-324.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.002803
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:12.467990) =========

========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2018-02-14 07:25:12.468309) =========
bash -c 'python archiver_client.py mozharness --repo projects/birch --rev e7dd761c5ba89c16d566b4ce1544526d8a6395c2 --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 e7dd761c5ba89c16d566b4ce1544526d8a6395c2 --destination scripts --debug']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-324.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-14 07:25:12,518 truncating revision to first 12 chars
2018-02-14 07:25:12,518 Setting DEBUG logging.
2018-02-14 07:25:12,518 attempt 1/10
2018-02-14 07:25:12,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/birch/e7dd761c5ba8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2018-02-14 07:25:13,218 attempt 1/10
2018-02-14 07:25:13,956 current task status: no status available at this point. state: STARTED
2018-02-14 07:25:13,956 sleeping for 10.00s (attempt 1/10)
2018-02-14 07:25:23,966 attempt 2/10
2018-02-14 07:25:24,500 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS
2018-02-14 07:25:24,618 unpacking tar archive at: birch-e7dd761c5ba8/testing/mozharness/
program finished with exit code 0
elapsedTime=12.303823
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2018-02-14 07:25:24.780231) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:24.780562) =========
script_repo_revision: e7dd761c5ba89c16d566b4ce1544526d8a6395c2
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:24.780977) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:24.781251) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:24.787320) =========

========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 18 secs) (at 2018-02-14 07:25:24.787592) =========
/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-324.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
07:25:25     INFO - MultiFileLogger online at 20180214 07:25:25 in /builds/slave/rel-bir_fx_bncr_sub-0000000000
07:25:25     INFO - Using buildbot properties:
07:25:25     INFO - {
07:25:25     INFO -     "project": "", 
07:25:25     INFO -     "product": "firefox", 
07:25:25     INFO -     "build_number": 7, 
07:25:25     INFO -     "taskId": "MLakxeG8Sn2zYzSMi7d7FQ", 
07:25:25     INFO -     "repository": "https://hg.mozilla.org/projects/birch", 
07:25:25     INFO -     "buildername": "release-birch_firefox_bncr_sub", 
07:25:25     INFO -     "balrog_api_root": "https://balrog-admin.stage.mozaws.net/api", 
07:25:25     INFO -     "basedir": "/builds/slave/rel-bir_fx_bncr_sub-0000000000", 
07:25:25     INFO -     "appVersion": "61.0", 
07:25:25     INFO -     "buildnumber": 15, 
07:25:25     INFO -     "slavename": "bld-linux64-spot-324", 
07:25:25     INFO -     "version": "61.0", 
07:25:25     INFO -     "release_promotion": true, 
07:25:25     INFO -     "platform": null, 
07:25:25     INFO -     "branch": "birch", 
07:25:25     INFO -     "script_repo_revision": "e7dd761c5ba89c16d566b4ce1544526d8a6395c2", 
07:25:25     INFO -     "master": "http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/", 
07:25:25     INFO -     "revision": "e7dd761c5ba89c16d566b4ce1544526d8a6395c2", 
07:25:25     INFO -     "partial_versions": "58.0b13build1, 57.0build4", 
07:25:25     INFO -     "next_version": "61.0.1", 
07:25:25     INFO -     "repo_path": "projects/birch"
07:25:25     INFO - }
07:25:25     INFO - Overriding product with firefox
07:25:25     INFO - Overriding version with 61.0
07:25:25     INFO - Overriding build_number with 7
07:25:25     INFO - Overriding revision with e7dd761c5ba89c16d566b4ce1544526d8a6395c2
07:25:25     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
07:25:25     INFO - Dumping config to /builds/slave/rel-bir_fx_bncr_sub-0000000000/logs/localconfig.json.
07:25:25     INFO - {'append_to_log': False,
07:25:25     INFO -  'base_work_dir': '/builds/slave/rel-bir_fx_bncr_sub-0000000000',
07:25:25     INFO -  'bouncer-api-prefix': 'https://admin-bouncer-releng.stage.mozaws.net/api',
07:25:25     INFO -  'build_number': 7,
07:25:25     INFO -  'buildbot_json_path': 'buildprops.json',
07:25:25     INFO -  'config_files': ('releases/bouncer_firefox_release.py',),
07:25:25     INFO -  'credentials_file': 'oauth.txt',
07:25:25     INFO -  'log_level': 'info',
07:25:25     INFO -  'log_to_console': True,
07:25:25     INFO -  'opt_config_files': (),
07:25:25     INFO -  'partials': {'candidates-dir': {'add-locales': True,
07:25:25     INFO -                                  'check_uptake': False,
07:25:25     INFO -                                  'paths': {'linux': {'bouncer-platform': 'linux',
07:25:25     INFO -                                                      'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
07:25:25     INFO -                                            'linux64': {'bouncer-platform': 'linux64',
07:25:25     INFO -                                                        'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
07:25:25     INFO -                                            'macosx64': {'bouncer-platform': 'osx',
07:25:25     INFO -                                                         'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
07:25:25     INFO -                                            'win32': {'bouncer-platform': 'win',
07:25:25     INFO -                                                      'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
07:25:25     INFO -                                            'win64': {'bouncer-platform': 'win64',
07:25:25     INFO -                                                      'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
07:25:25     INFO -                                  'product-name': 'Firefox-%(version)sbuild%(build_number)s-Partial-%(prev_version)sbuild%(prev_build_number)s',
07:25:25     INFO -                                  'ssl-only': False},
07:25:25     INFO -               'releases-dir': {'add-locales': True,
07:25:25     INFO -                                'check_uptake': True,
07:25:25     INFO -                                'paths': {'linux': {'bouncer-platform': 'linux',
07:25:25     INFO -                                                    'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
07:25:25     INFO -                                          'linux64': {'bouncer-platform': 'linux64',
07:25:25     INFO -                                                      'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
07:25:25     INFO -                                          'macosx64': {'bouncer-platform': 'osx',
07:25:25     INFO -                                                       'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
07:25:25     INFO -                                          'win32': {'bouncer-platform': 'win',
07:25:25     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
07:25:25     INFO -                                          'win64': {'bouncer-platform': 'win64',
07:25:25     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
07:25:25     INFO -                                'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s',
07:25:25     INFO -                                'ssl-only': False}},
07:25:25     INFO -  'prev_versions': (u'58.0b13build1', u'57.0build4'),
07:25:25     INFO -  'product': u'firefox',
07:25:25     INFO -  'products': {'complete-mar': {'add-locales': True,
07:25:25     INFO -                                'check_uptake': True,
07:25:25     INFO -                                'paths': {'linux': {'bouncer-platform': 'linux',
07:25:25     INFO -                                                    'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
07:25:25     INFO -                                          'linux64': {'bouncer-platform': 'linux64',
07:25:25     INFO -                                                      'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
07:25:25     INFO -                                          'macosx64': {'bouncer-platform': 'osx',
07:25:25     INFO -                                                       'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
07:25:25     INFO -                                          'win32': {'bouncer-platform': 'win',
07:25:25     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
07:25:25     INFO -                                          'win64': {'bouncer-platform': 'win64',
07:25:25     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
07:25:25     INFO -                                'product-name': 'Firefox-%(version)s-Complete',
07:25:25     INFO -                                'ssl-only': False},
07:25:25     INFO -               'complete-mar-candidates': {'add-locales': True,
07:25:25     INFO -                                           'check_uptake': False,
07:25:25     INFO -                                           'paths': {'linux': {'bouncer-platform': 'linux',
07:25:25     INFO -                                                               'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
07:25:25     INFO -                                                     'linux64': {'bouncer-platform': 'linux64',
07:25:25     INFO -                                                                 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
07:25:25     INFO -                                                     'macosx64': {'bouncer-platform': 'osx',
07:25:25     INFO -                                                                  'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
07:25:25     INFO -                                                     'win32': {'bouncer-platform': 'win',
07:25:25     INFO -                                                               'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
07:25:25     INFO -                                                     'win64': {'bouncer-platform': 'win64',
07:25:25     INFO -                                                               'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
07:25:25     INFO -                                           'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete',
07:25:25     INFO -                                           'ssl-only': False},
07:25:25     INFO -               'installer': {'add-locales': True,
07:25:25     INFO -                             'alias': 'firefox-latest',
07:25:25     INFO -                             'check_uptake': True,
07:25:25     INFO -                             'paths': {'linux': {'bouncer-platform': 'linux',
07:25:25     INFO -                                                 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
07:25:25     INFO -                                       'linux64': {'bouncer-platform': 'linux64',
07:25:25     INFO -                                                   'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
07:25:25     INFO -                                       'macosx64': {'bouncer-platform': 'osx',
07:25:25     INFO -                                                    'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
07:25:25     INFO -                                       'win32': {'bouncer-platform': 'win',
07:25:25     INFO -                                                 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
07:25:25     INFO -                                       'win64': {'bouncer-platform': 'win64',
07:25:25     INFO -                                                 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
07:25:25     INFO -                             'product-name': 'Firefox-%(version)s',
07:25:25     INFO -                             'ssl-only': False},
07:25:25     INFO -               'installer-ssl': {'add-locales': True,
07:25:25     INFO -                                 'alias': 'firefox-latest-ssl',
07:25:25     INFO -                                 'check_uptake': True,
07:25:25     INFO -                                 'paths': {'linux': {'bouncer-platform': 'linux',
07:25:25     INFO -                                                     'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
07:25:25     INFO -                                           'linux64': {'bouncer-platform': 'linux64',
07:25:25     INFO -                                                       'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
07:25:25     INFO -                                           'macosx64': {'bouncer-platform': 'osx',
07:25:25     INFO -                                                        'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
07:25:25     INFO -                                           'win32': {'bouncer-platform': 'win',
07:25:25     INFO -                                                     'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
07:25:25     INFO -                                           'win64': {'bouncer-platform': 'win64',
07:25:25     INFO -                                                     'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
07:25:25     INFO -                                 'product-name': 'Firefox-%(version)s-SSL',
07:25:25     INFO -                                 'ssl-only': True},
07:25:25     INFO -               'stub-installer': {'add-locales': True,
07:25:25     INFO -                                  'alias': 'firefox-stub',
07:25:25     INFO -                                  'check_uptake': True,
07:25:25     INFO -                                  'paths': {'win32': {'bouncer-platform': 'win',
07:25:25     INFO -                                                      'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'},
07:25:25     INFO -                                            'win64': {'bouncer-platform': 'win64',
07:25:25     INFO -                                                      'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}},
07:25:25     INFO -                                  'product-name': 'Firefox-%(version)s-stub',
07:25:25     INFO -                                  'ssl-only': True}},
07:25:25     INFO -  'repo': 'projects/birch',
07:25:25     INFO -  'revision': u'e7dd761c5ba89c16d566b4ce1544526d8a6395c2',
07:25:25     INFO -  'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales',
07:25:25     INFO -  'version': u'61.0',
07:25:25     INFO -  'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
07:25:25     INFO -  'work_dir': 'build'}
07:25:25     INFO - [mozharness: 2018-02-14 15:25:25.458293Z] Running clobber step.
07:25:25     INFO - Running main action method: clobber
07:25:25     INFO - rmtree: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build
07:25:25     INFO - [mozharness: 2018-02-14 15:25:25.461438Z] Finished clobber step (success)
07:25:25     INFO - [mozharness: 2018-02-14 15:25:25.461756Z] Running download-shipped-locales step.
07:25:25     INFO - Running main action method: download_shipped_locales
07:25:25     INFO - mkdir: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build
07:25:25     INFO - Downloading https://hg.mozilla.org/projects/birch/raw-file/e7dd761c5ba89c16d566b4ce1544526d8a6395c2/browser/locales/shipped-locales to /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales
07:25:25     INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://hg.mozilla.org/projects/birch/raw-file/e7dd761c5ba89c16d566b4ce1544526d8a6395c2/browser/locales/shipped-locales', 'file_name': '/builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales'}, attempt #1
07:25:26     INFO - Downloaded 18 bytes.
07:25:26     INFO - Reading from file /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales
07:25:26     INFO - Contents:
07:25:26     INFO -  de
07:25:26     INFO -  en-US
07:25:26     INFO -  ru
07:25:26     INFO -  zh-TW
07:25:26     INFO - [mozharness: 2018-02-14 15:25:26.512403Z] Finished download-shipped-locales step (success)
07:25:26     INFO - [mozharness: 2018-02-14 15:25:26.512587Z] Running submit step.
07:25:26     INFO - Running main action method: submit
07:25:26     INFO - Checking if Firefox-61.0-Complete already exists
07:25:26     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-Complete', None), kwargs: {}, attempt #1
07:25:26     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-Complete
07:25:27     INFO - Server response
07:25:27     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>
07:25:27     INFO - Products found: 1
07:25:27  WARNING - Product Firefox-61.0-Complete already exists. Skipping...
07:25:27     INFO - Checking if Firefox-61.0build7-Complete already exists
07:25:27     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0build7-Complete', None), kwargs: {}, attempt #1
07:25:27     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0build7-Complete
07:25:27     INFO - Server response
07:25:27     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
07:25:27     INFO - Products found: 0
07:25:27     INFO - Adding complete-mar-candidates...
07:25:27     INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'ru', 'zh-TW'], 'product': u'Firefox-61.0build7-Complete'}), kwargs: {}, attempt #1
07:25:27     INFO - POST data: languages=de&languages=en-US&languages=ru&languages=zh-TW&product=Firefox-61.0build7-Complete
07:25:27     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
07:25:28     INFO - Server response
07:25:28     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8445" name="Firefox-61.0build7-Complete"><language locale="de"/><language locale="en-US"/><language locale="ru"/><language locale="zh-TW"/></product></products>
07:25:28     INFO - Adding paths...
07:25:28     INFO - linux (linux): /firefox/candidates/61.0-candidates/build7/update/linux-i686/:lang/firefox-61.0.complete.mar
07:25:28     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/linux-i686/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build7-Complete', 'os': 'linux'}), kwargs: {}, attempt #1
07:25:28     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build7-Complete&os=linux
07:25:28     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:29     INFO - Server response
07:25:29     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8445" name="Firefox-61.0build7-Complete"><location id="42484" os="linux">/firefox/candidates/61.0-candidates/build7/update/linux-i686/:lang/firefox-61.0.complete.mar</location></product></locations>
07:25:29     INFO - linux64 (linux64): /firefox/candidates/61.0-candidates/build7/update/linux-x86_64/:lang/firefox-61.0.complete.mar
07:25:29     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/linux-x86_64/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build7-Complete', 'os': 'linux64'}), kwargs: {}, attempt #1
07:25:29     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build7-Complete&os=linux64
07:25:29     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:29     INFO - Server response
07:25:29     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8445" name="Firefox-61.0build7-Complete"><location id="42485" os="linux64">/firefox/candidates/61.0-candidates/build7/update/linux-x86_64/:lang/firefox-61.0.complete.mar</location></product></locations>
07:25:29     INFO - macosx64 (osx): /firefox/candidates/61.0-candidates/build7/update/mac/:lang/firefox-61.0.complete.mar
07:25:29     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/mac/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build7-Complete', 'os': 'osx'}), kwargs: {}, attempt #1
07:25:29     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build7-Complete&os=osx
07:25:29     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:30     INFO - Server response
07:25:30     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8445" name="Firefox-61.0build7-Complete"><location id="42486" os="osx">/firefox/candidates/61.0-candidates/build7/update/mac/:lang/firefox-61.0.complete.mar</location></product></locations>
07:25:30     INFO - win32 (win): /firefox/candidates/61.0-candidates/build7/update/win32/:lang/firefox-61.0.complete.mar
07:25:30     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/win32/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build7-Complete', 'os': 'win'}), kwargs: {}, attempt #1
07:25:30     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build7-Complete&os=win
07:25:30     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:31     INFO - Server response
07:25:31     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8445" name="Firefox-61.0build7-Complete"><location id="42487" os="win">/firefox/candidates/61.0-candidates/build7/update/win32/:lang/firefox-61.0.complete.mar</location></product></locations>
07:25:31     INFO - win64 (win64): /firefox/candidates/61.0-candidates/build7/update/win64/:lang/firefox-61.0.complete.mar
07:25:31     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/win64/:lang/firefox-61.0.complete.mar', 'product': u'Firefox-61.0build7-Complete', 'os': 'win64'}), kwargs: {}, attempt #1
07:25:31     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-61.0.complete.mar&product=Firefox-61.0build7-Complete&os=win64
07:25:31     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:31     INFO - Server response
07:25:31     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8445" name="Firefox-61.0build7-Complete"><location id="42488" os="win64">/firefox/candidates/61.0-candidates/build7/update/win64/:lang/firefox-61.0.complete.mar</location></product></locations>
07:25:31     INFO - Checking if Firefox-61.0 already exists
07:25:31     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0', None), kwargs: {}, attempt #1
07:25:31     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0
07:25:32     INFO - Server response
07:25:32     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>
07:25:32     INFO - Products found: 1
07:25:32  WARNING - Product Firefox-61.0 already exists. Skipping...
07:25:32     INFO - Checking if Firefox-61.0-SSL already exists
07:25:32     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-SSL', None), kwargs: {}, attempt #1
07:25:32     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-SSL
07:25:32     INFO - Server response
07:25:32     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>
07:25:32     INFO - Products found: 1
07:25:32  WARNING - Product Firefox-61.0-SSL already exists. Skipping...
07:25:32     INFO - Checking if Firefox-61.0-stub already exists
07:25:32     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-stub', None), kwargs: {}, attempt #1
07:25:32     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-stub
07:25:33     INFO - Server response
07:25:33     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>
07:25:33     INFO - Products found: 1
07:25:33  WARNING - Product Firefox-61.0-stub already exists. Skipping...
07:25:33     INFO - Checking if Firefox-61.0build7-Partial-58.0b13build1 already exists
07:25:33     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0build7-Partial-58.0b13build1', None), kwargs: {}, attempt #1
07:25:33     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0build7-Partial-58.0b13build1
07:25:33     INFO - Server response
07:25:33     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
07:25:33     INFO - Products found: 0
07:25:33     INFO - Adding partial updates for Firefox-61.0build7-Partial-58.0b13build1
07:25:33     INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'ru', 'zh-TW'], 'product': u'Firefox-61.0build7-Partial-58.0b13build1'}), kwargs: {}, attempt #1
07:25:33     INFO - POST data: languages=de&languages=en-US&languages=ru&languages=zh-TW&product=Firefox-61.0build7-Partial-58.0b13build1
07:25:34     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
07:25:34     INFO - Server response
07:25:34     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8446" name="Firefox-61.0build7-Partial-58.0b13build1"><language locale="de"/><language locale="en-US"/><language locale="ru"/><language locale="zh-TW"/></product></products>
07:25:34     INFO - linux (linux): /firefox/candidates/61.0-candidates/build7/update/linux-i686/:lang/firefox-58.0b13-61.0.partial.mar
07:25:34     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/linux-i686/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build7-Partial-58.0b13build1', 'os': 'linux'}), kwargs: {}, attempt #1
07:25:34     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build7-Partial-58.0b13build1&os=linux
07:25:34     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:35     INFO - Server response
07:25:35     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8446" name="Firefox-61.0build7-Partial-58.0b13build1"><location id="42489" os="linux">/firefox/candidates/61.0-candidates/build7/update/linux-i686/:lang/firefox-58.0b13-61.0.partial.mar</location></product></locations>
07:25:35     INFO - linux64 (linux64): /firefox/candidates/61.0-candidates/build7/update/linux-x86_64/:lang/firefox-58.0b13-61.0.partial.mar
07:25:35     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/linux-x86_64/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build7-Partial-58.0b13build1', 'os': 'linux64'}), kwargs: {}, attempt #1
07:25:35     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build7-Partial-58.0b13build1&os=linux64
07:25:35     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:35     INFO - Server response
07:25:35     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8446" name="Firefox-61.0build7-Partial-58.0b13build1"><location id="42490" os="linux64">/firefox/candidates/61.0-candidates/build7/update/linux-x86_64/:lang/firefox-58.0b13-61.0.partial.mar</location></product></locations>
07:25:35     INFO - macosx64 (osx): /firefox/candidates/61.0-candidates/build7/update/mac/:lang/firefox-58.0b13-61.0.partial.mar
07:25:35     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/mac/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build7-Partial-58.0b13build1', 'os': 'osx'}), kwargs: {}, attempt #1
07:25:35     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build7-Partial-58.0b13build1&os=osx
07:25:35     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:36     INFO - Server response
07:25:36     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8446" name="Firefox-61.0build7-Partial-58.0b13build1"><location id="42491" os="osx">/firefox/candidates/61.0-candidates/build7/update/mac/:lang/firefox-58.0b13-61.0.partial.mar</location></product></locations>
07:25:36     INFO - win32 (win): /firefox/candidates/61.0-candidates/build7/update/win32/:lang/firefox-58.0b13-61.0.partial.mar
07:25:36     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/win32/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build7-Partial-58.0b13build1', 'os': 'win'}), kwargs: {}, attempt #1
07:25:36     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build7-Partial-58.0b13build1&os=win
07:25:36     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:37     INFO - Server response
07:25:37     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8446" name="Firefox-61.0build7-Partial-58.0b13build1"><location id="42492" os="win">/firefox/candidates/61.0-candidates/build7/update/win32/:lang/firefox-58.0b13-61.0.partial.mar</location></product></locations>
07:25:37     INFO - win64 (win64): /firefox/candidates/61.0-candidates/build7/update/win64/:lang/firefox-58.0b13-61.0.partial.mar
07:25:37     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/win64/:lang/firefox-58.0b13-61.0.partial.mar', 'product': u'Firefox-61.0build7-Partial-58.0b13build1', 'os': 'win64'}), kwargs: {}, attempt #1
07:25:37     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-58.0b13-61.0.partial.mar&product=Firefox-61.0build7-Partial-58.0b13build1&os=win64
07:25:37     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:37     INFO - Server response
07:25:37     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8446" name="Firefox-61.0build7-Partial-58.0b13build1"><location id="42493" os="win64">/firefox/candidates/61.0-candidates/build7/update/win64/:lang/firefox-58.0b13-61.0.partial.mar</location></product></locations>
07:25:37     INFO - Checking if Firefox-61.0build7-Partial-57.0build4 already exists
07:25:37     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0build7-Partial-57.0build4', None), kwargs: {}, attempt #1
07:25:37     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0build7-Partial-57.0build4
07:25:38     INFO - Server response
07:25:38     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
07:25:38     INFO - Products found: 0
07:25:38     INFO - Adding partial updates for Firefox-61.0build7-Partial-57.0build4
07:25:38     INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['de', 'en-US', 'ru', 'zh-TW'], 'product': u'Firefox-61.0build7-Partial-57.0build4'}), kwargs: {}, attempt #1
07:25:38     INFO - POST data: languages=de&languages=en-US&languages=ru&languages=zh-TW&product=Firefox-61.0build7-Partial-57.0build4
07:25:38     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
07:25:39     INFO - Server response
07:25:39     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="8447" name="Firefox-61.0build7-Partial-57.0build4"><language locale="de"/><language locale="en-US"/><language locale="ru"/><language locale="zh-TW"/></product></products>
07:25:39     INFO - linux (linux): /firefox/candidates/61.0-candidates/build7/update/linux-i686/:lang/firefox-57.0-61.0.partial.mar
07:25:39     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/linux-i686/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build7-Partial-57.0build4', 'os': 'linux'}), kwargs: {}, attempt #1
07:25:39     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build7-Partial-57.0build4&os=linux
07:25:39     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:39     INFO - Server response
07:25:39     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8447" name="Firefox-61.0build7-Partial-57.0build4"><location id="42494" os="linux">/firefox/candidates/61.0-candidates/build7/update/linux-i686/:lang/firefox-57.0-61.0.partial.mar</location></product></locations>
07:25:39     INFO - linux64 (linux64): /firefox/candidates/61.0-candidates/build7/update/linux-x86_64/:lang/firefox-57.0-61.0.partial.mar
07:25:39     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/linux-x86_64/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build7-Partial-57.0build4', 'os': 'linux64'}), kwargs: {}, attempt #1
07:25:39     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build7-Partial-57.0build4&os=linux64
07:25:39     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:40     INFO - Server response
07:25:40     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8447" name="Firefox-61.0build7-Partial-57.0build4"><location id="42495" os="linux64">/firefox/candidates/61.0-candidates/build7/update/linux-x86_64/:lang/firefox-57.0-61.0.partial.mar</location></product></locations>
07:25:40     INFO - macosx64 (osx): /firefox/candidates/61.0-candidates/build7/update/mac/:lang/firefox-57.0-61.0.partial.mar
07:25:40     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/mac/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build7-Partial-57.0build4', 'os': 'osx'}), kwargs: {}, attempt #1
07:25:40     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build7-Partial-57.0build4&os=osx
07:25:40     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:40     INFO - Server response
07:25:40     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8447" name="Firefox-61.0build7-Partial-57.0build4"><location id="42496" os="osx">/firefox/candidates/61.0-candidates/build7/update/mac/:lang/firefox-57.0-61.0.partial.mar</location></product></locations>
07:25:40     INFO - win32 (win): /firefox/candidates/61.0-candidates/build7/update/win32/:lang/firefox-57.0-61.0.partial.mar
07:25:40     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/win32/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build7-Partial-57.0build4', 'os': 'win'}), kwargs: {}, attempt #1
07:25:40     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build7-Partial-57.0build4&os=win
07:25:40     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:41     INFO - Server response
07:25:41     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8447" name="Firefox-61.0build7-Partial-57.0build4"><location id="42497" os="win">/firefox/candidates/61.0-candidates/build7/update/win32/:lang/firefox-57.0-61.0.partial.mar</location></product></locations>
07:25:41     INFO - win64 (win64): /firefox/candidates/61.0-candidates/build7/update/win64/:lang/firefox-57.0-61.0.partial.mar
07:25:41     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/61.0-candidates/build7/update/win64/:lang/firefox-57.0-61.0.partial.mar', 'product': u'Firefox-61.0build7-Partial-57.0build4', 'os': 'win64'}), kwargs: {}, attempt #1
07:25:41     INFO - POST data: path=%2Ffirefox%2Fcandidates%2F61.0-candidates%2Fbuild7%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-57.0-61.0.partial.mar&product=Firefox-61.0build7-Partial-57.0build4&os=win64
07:25:41     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
07:25:42     INFO - Server response
07:25:42     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="8447" name="Firefox-61.0build7-Partial-57.0build4"><location id="42498" os="win64">/firefox/candidates/61.0-candidates/build7/update/win64/:lang/firefox-57.0-61.0.partial.mar</location></product></locations>
07:25:42     INFO - Checking if Firefox-61.0-Partial-58.0b13 already exists
07:25:42     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-Partial-58.0b13', None), kwargs: {}, attempt #1
07:25:42     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-Partial-58.0b13
07:25:42     INFO - Server response
07:25:42     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>
07:25:42     INFO - Products found: 1
07:25:42  WARNING - Product Firefox-61.0-Partial-58.0b13 already exists. Skipping...
07:25:42     INFO - Checking if Firefox-61.0-Partial-57.0 already exists
07:25:42     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-61.0-Partial-57.0', None), kwargs: {}, attempt #1
07:25:42     INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-61.0-Partial-57.0
07:25:43     INFO - Server response
07:25:43     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>
07:25:43     INFO - Products found: 1
07:25:43  WARNING - Product Firefox-61.0-Partial-57.0 already exists. Skipping...
07:25:43     INFO - [mozharness: 2018-02-14 15:25:43.162615Z] Finished submit step (success)
07:25:43     INFO - Running post-run listener: copy_logs_to_upload_dir
07:25:43     INFO - Copying logs to upload dir...
07:25:43     INFO - mkdir: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/upload/logs
07:25:43     INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=18.379499
========= master_lag: 0.01 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 18 secs) (at 2018-02-14 07:25:43.180205) =========

========= Started no change (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:43.182872) =========
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-324.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.004912

========= master_lag: 0.04 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:43.230443) =========

========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:43.230752) =========
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-324.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.002503
========= master_lag: 0.04 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-02-14 07:25:43.277007) =========

========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2018-02-14 07:25:43.277288) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2018-02-14 07:25:43.277524) =========

========= Total master_lag: 0.16 =========