builder: release-date_firefox_bncr_sub
slave: bld-linux64-spot-426
starttime: 1457414409.79
results: success (0)
revision: e1da13e006f645900a95c2f8a64fe4968b0d50b2

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:09.794280) =========
master: http://buildbot-master91.bb.releng.usw2.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:09.794718) =========

========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:09.795035) =========
bash -c pwd
 in dir /builds/slave/rel-date_fx_bncr_sub-000000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'pwd']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-426.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-date_fx_bncr_sub-000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
/builds/slave/rel-date_fx_bncr_sub-000000000
program finished with exit code 0
elapsedTime=0.004078
basedir: '/builds/slave/rel-date_fx_bncr_sub-000000000'
========= master_lag: 0.02 =========
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:09.815053) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:09.815341) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:09.828458) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:09.828723) =========
rm -rf properties
 in dir /builds/slave/rel-date_fx_bncr_sub-000000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'properties']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-426.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-date_fx_bncr_sub-000000000
  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.002634
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:09.875328) =========

========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:09.875621) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:09.875993) =========

========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:09.876272) =========
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-date_fx_bncr_sub-000000000/. (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-426.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-date_fx_bncr_sub-000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
--2016-03-07 21:20:09--  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: 12141 (12K) [text/x-python]
Saving to: ‘archiver_client.py’

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

2016-03-07 21:20:10 (85.5 MB/s) - ‘archiver_client.py’ saved [12141/12141]

program finished with exit code 0
elapsedTime=0.218665
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:10.106879) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:10.107214) =========
rm -rf scripts
 in dir /builds/slave/rel-date_fx_bncr_sub-000000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'scripts']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-426.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-date_fx_bncr_sub-000000000
  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.002870
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:10.154327) =========

========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:10.154663) =========
bash -c 'python archiver_client.py mozharness --repo projects/date --rev e1da13e006f645900a95c2f8a64fe4968b0d50b2 --destination scripts --debug'
 in dir /builds/slave/rel-date_fx_bncr_sub-000000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/date --rev e1da13e006f645900a95c2f8a64fe4968b0d50b2 --destination scripts --debug']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-426.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-date_fx_bncr_sub-000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
2016-03-07 21:20:10,202 truncating revision to first 12 chars
2016-03-07 21:20:10,202 Setting DEBUG logging.
2016-03-07 21:20:10,202 attempt 1/10
2016-03-07 21:20:10,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/e1da13e006f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-03-07 21:20:10,473 unpacking tar archive at: date-e1da13e006f6/testing/mozharness/
program finished with exit code 0
elapsedTime=0.430447
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:10.597000) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:10.597326) =========
echo e1da13e006f645900a95c2f8a64fe4968b0d50b2
 in dir /builds/slave/rel-date_fx_bncr_sub-000000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['echo', 'e1da13e006f645900a95c2f8a64fe4968b0d50b2']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-426.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-date_fx_bncr_sub-000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
e1da13e006f645900a95c2f8a64fe4968b0d50b2
program finished with exit code 0
elapsedTime=0.003165
script_repo_revision: 'e1da13e006f645900a95c2f8a64fe4968b0d50b2'
========= master_lag: 0.04 =========
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:10.645122) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:10.645764) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:10.655004) =========

========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 23 secs) (at 2016-03-07 21:20:10.655279) =========
/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_date.py --credentials-file oauth.txt --bouncer-api-prefix https://admin-bouncer.stage.mozaws.net/api --repo projects/date
 in dir /builds/slave/rel-date_fx_bncr_sub-000000000/. (timeout 3600 secs) (maxTime 14400 secs)
 watching logfiles {}
 argv: ['/tools/buildbot/bin/python', 'scripts/scripts/bouncer_submitter.py', '-c', 'releases/bouncer_firefox_date.py', '--credentials-file', 'oauth.txt', '--bouncer-api-prefix', 'https://admin-bouncer.stage.mozaws.net/api', '--repo', 'projects/date']
 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-426.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
  MOZ_SYMBOLS_EXTRA_BUILDID=linux64-date
  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
  POST_SYMBOL_UPLOAD_CMD=/usr/local/bin/post-symbol-upload.py
  PROPERTIES_FILE=/builds/slave/rel-date_fx_bncr_sub-000000000/buildprops.json
  PWD=/builds/slave/rel-date_fx_bncr_sub-000000000
  SHELL=/bin/bash
  SHLVL=1
  SYMBOL_SERVER_HOST=symbolpush.mozilla.org
  SYMBOL_SERVER_PATH=/mnt/netapp/breakpad/symbols_ffx/
  SYMBOL_SERVER_SSH_KEY=/home/mock_mozilla/.ssh/ffxbld_rsa
  SYMBOL_SERVER_USER=ffxbld
  TERM=linux
  TINDERBOX_OUTPUT=1
  TMOUT=86400
  TOOLTOOL_CACHE=/builds/tooltool_cache
  TOOLTOOL_HOME=/builds
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
21:20:10     INFO - MultiFileLogger online at 20160307 21:20:10 in /builds/slave/rel-date_fx_bncr_sub-000000000
21:20:10     INFO - Using buildbot properties:
21:20:10     INFO - {
21:20:10     INFO -     "project": "", 
21:20:10     INFO -     "product": "firefox", 
21:20:10     INFO -     "build_number": 1, 
21:20:10     INFO -     "taskId": "8dVbdmT3QUiVp3LsqRpxmg", 
21:20:10     INFO -     "repository": "", 
21:20:10     INFO -     "buildername": "release-date_firefox_bncr_sub", 
21:20:10     INFO -     "basedir": "/builds/slave/rel-date_fx_bncr_sub-000000000", 
21:20:10     INFO -     "buildnumber": 38, 
21:20:10     INFO -     "slavename": "bld-linux64-spot-426", 
21:20:10     INFO -     "version": "46.0b4", 
21:20:10     INFO -     "release_promotion": true, 
21:20:10     INFO -     "platform": null, 
21:20:10     INFO -     "branch": "releases/date", 
21:20:10     INFO -     "script_repo_revision": "e1da13e006f645900a95c2f8a64fe4968b0d50b2", 
21:20:10     INFO -     "master": "http://buildbot-master91.bb.releng.usw2.mozilla.com:8001/", 
21:20:10     INFO -     "revision": "e1da13e006f645900a95c2f8a64fe4968b0d50b2", 
21:20:10     INFO -     "partial_versions": "45.0b7build1, 45.0b8build1", 
21:20:10     INFO -     "repo_path": "projects/date"
21:20:10     INFO - }
21:20:10     INFO - Overriding product with firefox
21:20:10     INFO - Overriding version with 46.0b4
21:20:10     INFO - Overriding build_number with 1
21:20:10     INFO - Overriding revision with e1da13e006f645900a95c2f8a64fe4968b0d50b2
21:20:10     INFO - Run as scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_date.py --credentials-file oauth.txt --bouncer-api-prefix https://admin-bouncer.stage.mozaws.net/api --repo projects/date
21:20:10     INFO - Dumping config to /builds/slave/rel-date_fx_bncr_sub-000000000/logs/localconfig.json.
21:20:10     INFO - {'append_to_log': False,
21:20:10     INFO -  'base_work_dir': '/builds/slave/rel-date_fx_bncr_sub-000000000',
21:20:10     INFO -  'bouncer-api-prefix': 'https://admin-bouncer.stage.mozaws.net/api',
21:20:10     INFO -  'build_number': 1,
21:20:10     INFO -  'buildbot_json_path': 'buildprops.json',
21:20:10     INFO -  'config_files': ('releases/bouncer_firefox_date.py',),
21:20:10     INFO -  'credentials_file': 'oauth.txt',
21:20:10     INFO -  'log_level': 'info',
21:20:10     INFO -  'log_to_console': True,
21:20:10     INFO -  'opt_config_files': (),
21:20:10     INFO -  'partials': {'releases-dir': {'add-locales': False,
21:20:10     INFO -                                'paths': {'linux': {'bouncer-platform': 'linux',
21:20:10     INFO -                                                    'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
21:20:10     INFO -                                          'linux64': {'bouncer-platform': 'linux64',
21:20:10     INFO -                                                      'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
21:20:10     INFO -                                          'macosx64': {'bouncer-platform': 'osx',
21:20:10     INFO -                                                       'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
21:20:10     INFO -                                          'win32': {'bouncer-platform': 'win',
21:20:10     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
21:20:10     INFO -                                          'win64': {'bouncer-platform': 'win64',
21:20:10     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
21:20:10     INFO -                                'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s',
21:20:10     INFO -                                'ssl-only': False}},
21:20:10     INFO -  'prev_versions': (u'45.0b7build1', u'45.0b8build1'),
21:20:10     INFO -  'product': u'firefox',
21:20:10     INFO -  'products': {'complete-mar': {'add-locales': False,
21:20:10     INFO -                                'paths': {'linux': {'bouncer-platform': 'linux',
21:20:10     INFO -                                                    'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
21:20:10     INFO -                                          'linux64': {'bouncer-platform': 'linux64',
21:20:10     INFO -                                                      'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
21:20:10     INFO -                                          'macosx64': {'bouncer-platform': 'osx',
21:20:10     INFO -                                                       'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
21:20:10     INFO -                                          'win32': {'bouncer-platform': 'win',
21:20:10     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
21:20:10     INFO -                                          'win64': {'bouncer-platform': 'win64',
21:20:10     INFO -                                                    'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
21:20:10     INFO -                                'product-name': 'Firefox-%(version)s-Complete',
21:20:10     INFO -                                'ssl-only': False},
21:20:10     INFO -               'installer': {'add-locales': False,
21:20:10     INFO -                             'paths': {'linux': {'bouncer-platform': 'linux',
21:20:10     INFO -                                                 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
21:20:10     INFO -                                       'linux64': {'bouncer-platform': 'linux64',
21:20:10     INFO -                                                   'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
21:20:10     INFO -                                       'macosx64': {'bouncer-platform': 'osx',
21:20:10     INFO -                                                    'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
21:20:10     INFO -                                       'win32': {'bouncer-platform': 'win',
21:20:10     INFO -                                                 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
21:20:10     INFO -                                       'win64': {'bouncer-platform': 'win64',
21:20:10     INFO -                                                 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
21:20:10     INFO -                             'product-name': 'Firefox-%(version)s',
21:20:10     INFO -                             'ssl-only': False},
21:20:10     INFO -               'installer-ssl': {'add-locales': False,
21:20:10     INFO -                                 'paths': {'linux': {'bouncer-platform': 'linux',
21:20:10     INFO -                                                     'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
21:20:10     INFO -                                           'linux64': {'bouncer-platform': 'linux64',
21:20:10     INFO -                                                       'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
21:20:10     INFO -                                           'macosx64': {'bouncer-platform': 'osx',
21:20:10     INFO -                                                        'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
21:20:10     INFO -                                           'win32': {'bouncer-platform': 'win',
21:20:10     INFO -                                                     'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
21:20:10     INFO -                                           'win64': {'bouncer-platform': 'win64',
21:20:10     INFO -                                                     'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
21:20:10     INFO -                                 'product-name': 'Firefox-%(version)s-SSL',
21:20:10     INFO -                                 'ssl-only': True},
21:20:10     INFO -               'stub-installer': {'add-locales': False,
21:20:10     INFO -                                  'paths': {'win32': {'bouncer-platform': 'win',
21:20:10     INFO -                                                      'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'},
21:20:10     INFO -                                            'win64': {'bouncer-platform': 'win64',
21:20:10     INFO -                                                      'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}},
21:20:10     INFO -                                  'product-name': 'Firefox-%(version)s-stub',
21:20:10     INFO -                                  'ssl-only': True}},
21:20:10     INFO -  'repo': 'projects/date',
21:20:10     INFO -  'revision': u'e1da13e006f645900a95c2f8a64fe4968b0d50b2',
21:20:10     INFO -  'version': u'46.0b4',
21:20:10     INFO -  'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
21:20:10     INFO -  'work_dir': 'build'}
21:20:10     INFO - #####
21:20:10     INFO - ##### Running clobber step.
21:20:10     INFO - #####
21:20:10     INFO - Running main action method: clobber
21:20:10     INFO - rmtree: /builds/slave/rel-date_fx_bncr_sub-000000000/build
21:20:10     INFO - #####
21:20:10     INFO - ##### Running download-shipped-locales step.
21:20:10     INFO - #####
21:20:10     INFO - Running main action method: download_shipped_locales
21:20:10     INFO - No need to download shipped-locales
21:20:10     INFO - #####
21:20:10     INFO - ##### Running submit step.
21:20:10     INFO - #####
21:20:10     INFO - Running main action method: submit
21:20:10     INFO - Checking if Firefox-46.0b4-Complete already exists
21:20:10     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b4-Complete', None), kwargs: {}, attempt #1
21:20:10     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b4-Complete
21:20:11     INFO - Server response
21:20:11     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
21:20:11     INFO - Products found: 0
21:20:11     INFO - Adding complete-mar...
21:20:11     INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b4-Complete'}), kwargs: {}, attempt #1
21:20:11     INFO - POST data: product=Firefox-46.0b4-Complete
21:20:11     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
21:20:12     INFO - Server response
21:20:12     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="5355" name="Firefox-46.0b4-Complete"/></products>
21:20:12     INFO - Adding paths...
21:20:12     INFO - linux (linux): /firefox/releases/46.0b4/update/linux-i686/:lang/firefox-46.0b4.complete.mar
21:20:12     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/linux-i686/:lang/firefox-46.0b4.complete.mar', 'product': u'Firefox-46.0b4-Complete', 'os': 'linux'}), kwargs: {}, attempt #1
21:20:12     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-46.0b4.complete.mar&product=Firefox-46.0b4-Complete&os=linux
21:20:12     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:12     INFO - Server response
21:20:12     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5355" name="Firefox-46.0b4-Complete"><location id="27107" os="linux">/firefox/releases/46.0b4/update/linux-i686/:lang/firefox-46.0b4.complete.mar</location></product></locations>
21:20:12     INFO - linux64 (linux64): /firefox/releases/46.0b4/update/linux-x86_64/:lang/firefox-46.0b4.complete.mar
21:20:12     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/linux-x86_64/:lang/firefox-46.0b4.complete.mar', 'product': u'Firefox-46.0b4-Complete', 'os': 'linux64'}), kwargs: {}, attempt #1
21:20:12     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-46.0b4.complete.mar&product=Firefox-46.0b4-Complete&os=linux64
21:20:12     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:13     INFO - Server response
21:20:13     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5355" name="Firefox-46.0b4-Complete"><location id="27108" os="linux64">/firefox/releases/46.0b4/update/linux-x86_64/:lang/firefox-46.0b4.complete.mar</location></product></locations>
21:20:13     INFO - macosx64 (osx): /firefox/releases/46.0b4/update/mac/:lang/firefox-46.0b4.complete.mar
21:20:13     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/mac/:lang/firefox-46.0b4.complete.mar', 'product': u'Firefox-46.0b4-Complete', 'os': 'osx'}), kwargs: {}, attempt #1
21:20:13     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-46.0b4.complete.mar&product=Firefox-46.0b4-Complete&os=osx
21:20:13     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:13     INFO - Server response
21:20:13     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5355" name="Firefox-46.0b4-Complete"><location id="27109" os="osx">/firefox/releases/46.0b4/update/mac/:lang/firefox-46.0b4.complete.mar</location></product></locations>
21:20:13     INFO - win32 (win): /firefox/releases/46.0b4/update/win32/:lang/firefox-46.0b4.complete.mar
21:20:13     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/win32/:lang/firefox-46.0b4.complete.mar', 'product': u'Firefox-46.0b4-Complete', 'os': 'win'}), kwargs: {}, attempt #1
21:20:13     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-46.0b4.complete.mar&product=Firefox-46.0b4-Complete&os=win
21:20:13     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:14     INFO - Server response
21:20:14     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5355" name="Firefox-46.0b4-Complete"><location id="27110" os="win">/firefox/releases/46.0b4/update/win32/:lang/firefox-46.0b4.complete.mar</location></product></locations>
21:20:14     INFO - win64 (win64): /firefox/releases/46.0b4/update/win64/:lang/firefox-46.0b4.complete.mar
21:20:14     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/win64/:lang/firefox-46.0b4.complete.mar', 'product': u'Firefox-46.0b4-Complete', 'os': 'win64'}), kwargs: {}, attempt #1
21:20:14     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-46.0b4.complete.mar&product=Firefox-46.0b4-Complete&os=win64
21:20:14     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:14     INFO - Server response
21:20:14     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5355" name="Firefox-46.0b4-Complete"><location id="27111" os="win64">/firefox/releases/46.0b4/update/win64/:lang/firefox-46.0b4.complete.mar</location></product></locations>
21:20:14     INFO - Checking if Firefox-46.0b4 already exists
21:20:14     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b4', None), kwargs: {}, attempt #1
21:20:14     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b4
21:20:15     INFO - Server response
21:20:15     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
21:20:15     INFO - Products found: 0
21:20:15     INFO - Adding installer...
21:20:15     INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b4'}), kwargs: {}, attempt #1
21:20:15     INFO - POST data: product=Firefox-46.0b4
21:20:15     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
21:20:16     INFO - Server response
21:20:16     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="5356" name="Firefox-46.0b4"/></products>
21:20:16     INFO - Adding paths...
21:20:16     INFO - linux (linux): /firefox/releases/46.0b4/linux-i686/:lang/firefox-46.0b4.tar.bz2
21:20:16     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/linux-i686/:lang/firefox-46.0b4.tar.bz2', 'product': u'Firefox-46.0b4', 'os': 'linux'}), kwargs: {}, attempt #1
21:20:16     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Flinux-i686%2F%3Alang%2Ffirefox-46.0b4.tar.bz2&product=Firefox-46.0b4&os=linux
21:20:16     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:16     INFO - Server response
21:20:16     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5356" name="Firefox-46.0b4"><location id="27112" os="linux">/firefox/releases/46.0b4/linux-i686/:lang/firefox-46.0b4.tar.bz2</location></product></locations>
21:20:16     INFO - linux64 (linux64): /firefox/releases/46.0b4/linux-x86_64/:lang/firefox-46.0b4.tar.bz2
21:20:16     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/linux-x86_64/:lang/firefox-46.0b4.tar.bz2', 'product': u'Firefox-46.0b4', 'os': 'linux64'}), kwargs: {}, attempt #1
21:20:16     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Flinux-x86_64%2F%3Alang%2Ffirefox-46.0b4.tar.bz2&product=Firefox-46.0b4&os=linux64
21:20:16     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:17     INFO - Server response
21:20:17     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5356" name="Firefox-46.0b4"><location id="27113" os="linux64">/firefox/releases/46.0b4/linux-x86_64/:lang/firefox-46.0b4.tar.bz2</location></product></locations>
21:20:17     INFO - macosx64 (osx): /firefox/releases/46.0b4/mac/:lang/Firefox%2046.0b4.dmg
21:20:17     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/mac/:lang/Firefox%2046.0b4.dmg', 'product': u'Firefox-46.0b4', 'os': 'osx'}), kwargs: {}, attempt #1
21:20:17     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fmac%2F%3Alang%2FFirefox%252046.0b4.dmg&product=Firefox-46.0b4&os=osx
21:20:17     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:17     INFO - Server response
21:20:17     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5356" name="Firefox-46.0b4"><location id="27114" os="osx">/firefox/releases/46.0b4/mac/:lang/Firefox%2046.0b4.dmg</location></product></locations>
21:20:17     INFO - win32 (win): /firefox/releases/46.0b4/win32/:lang/Firefox%20Setup%2046.0b4.exe
21:20:17     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/win32/:lang/Firefox%20Setup%2046.0b4.exe', 'product': u'Firefox-46.0b4', 'os': 'win'}), kwargs: {}, attempt #1
21:20:17     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fwin32%2F%3Alang%2FFirefox%2520Setup%252046.0b4.exe&product=Firefox-46.0b4&os=win
21:20:17     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:18     INFO - Server response
21:20:18     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5356" name="Firefox-46.0b4"><location id="27115" os="win">/firefox/releases/46.0b4/win32/:lang/Firefox%20Setup%2046.0b4.exe</location></product></locations>
21:20:18     INFO - win64 (win64): /firefox/releases/46.0b4/win64/:lang/Firefox%20Setup%2046.0b4.exe
21:20:18     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/win64/:lang/Firefox%20Setup%2046.0b4.exe', 'product': u'Firefox-46.0b4', 'os': 'win64'}), kwargs: {}, attempt #1
21:20:18     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fwin64%2F%3Alang%2FFirefox%2520Setup%252046.0b4.exe&product=Firefox-46.0b4&os=win64
21:20:18     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:19     INFO - Server response
21:20:19     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5356" name="Firefox-46.0b4"><location id="27116" os="win64">/firefox/releases/46.0b4/win64/:lang/Firefox%20Setup%2046.0b4.exe</location></product></locations>
21:20:19     INFO - Checking if Firefox-46.0b4-SSL already exists
21:20:19     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b4-SSL', None), kwargs: {}, attempt #1
21:20:19     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b4-SSL
21:20:19     INFO - Server response
21:20:19     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
21:20:19     INFO - Products found: 0
21:20:19     INFO - Adding installer-ssl...
21:20:19     INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b4-SSL', 'ssl_only': 'true'}), kwargs: {}, attempt #1
21:20:19     INFO - POST data: product=Firefox-46.0b4-SSL&ssl_only=true
21:20:19     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
21:20:20     INFO - Server response
21:20:20     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="5357" name="Firefox-46.0b4-SSL"/></products>
21:20:20     INFO - Adding paths...
21:20:20     INFO - linux (linux): /firefox/releases/46.0b4/linux-i686/:lang/firefox-46.0b4.tar.bz2
21:20:20     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/linux-i686/:lang/firefox-46.0b4.tar.bz2', 'product': u'Firefox-46.0b4-SSL', 'os': 'linux'}), kwargs: {}, attempt #1
21:20:20     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Flinux-i686%2F%3Alang%2Ffirefox-46.0b4.tar.bz2&product=Firefox-46.0b4-SSL&os=linux
21:20:20     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:20     INFO - Server response
21:20:20     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5357" name="Firefox-46.0b4-SSL"><location id="27117" os="linux">/firefox/releases/46.0b4/linux-i686/:lang/firefox-46.0b4.tar.bz2</location></product></locations>
21:20:20     INFO - linux64 (linux64): /firefox/releases/46.0b4/linux-x86_64/:lang/firefox-46.0b4.tar.bz2
21:20:20     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/linux-x86_64/:lang/firefox-46.0b4.tar.bz2', 'product': u'Firefox-46.0b4-SSL', 'os': 'linux64'}), kwargs: {}, attempt #1
21:20:20     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Flinux-x86_64%2F%3Alang%2Ffirefox-46.0b4.tar.bz2&product=Firefox-46.0b4-SSL&os=linux64
21:20:20     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:21     INFO - Server response
21:20:21     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5357" name="Firefox-46.0b4-SSL"><location id="27118" os="linux64">/firefox/releases/46.0b4/linux-x86_64/:lang/firefox-46.0b4.tar.bz2</location></product></locations>
21:20:21     INFO - macosx64 (osx): /firefox/releases/46.0b4/mac/:lang/Firefox%2046.0b4.dmg
21:20:21     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/mac/:lang/Firefox%2046.0b4.dmg', 'product': u'Firefox-46.0b4-SSL', 'os': 'osx'}), kwargs: {}, attempt #1
21:20:21     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fmac%2F%3Alang%2FFirefox%252046.0b4.dmg&product=Firefox-46.0b4-SSL&os=osx
21:20:21     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:21     INFO - Server response
21:20:21     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5357" name="Firefox-46.0b4-SSL"><location id="27119" os="osx">/firefox/releases/46.0b4/mac/:lang/Firefox%2046.0b4.dmg</location></product></locations>
21:20:21     INFO - win32 (win): /firefox/releases/46.0b4/win32/:lang/Firefox%20Setup%2046.0b4.exe
21:20:21     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/win32/:lang/Firefox%20Setup%2046.0b4.exe', 'product': u'Firefox-46.0b4-SSL', 'os': 'win'}), kwargs: {}, attempt #1
21:20:21     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fwin32%2F%3Alang%2FFirefox%2520Setup%252046.0b4.exe&product=Firefox-46.0b4-SSL&os=win
21:20:21     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:22     INFO - Server response
21:20:22     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5357" name="Firefox-46.0b4-SSL"><location id="27120" os="win">/firefox/releases/46.0b4/win32/:lang/Firefox%20Setup%2046.0b4.exe</location></product></locations>
21:20:22     INFO - win64 (win64): /firefox/releases/46.0b4/win64/:lang/Firefox%20Setup%2046.0b4.exe
21:20:22     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/win64/:lang/Firefox%20Setup%2046.0b4.exe', 'product': u'Firefox-46.0b4-SSL', 'os': 'win64'}), kwargs: {}, attempt #1
21:20:22     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fwin64%2F%3Alang%2FFirefox%2520Setup%252046.0b4.exe&product=Firefox-46.0b4-SSL&os=win64
21:20:22     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:23     INFO - Server response
21:20:23     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5357" name="Firefox-46.0b4-SSL"><location id="27121" os="win64">/firefox/releases/46.0b4/win64/:lang/Firefox%20Setup%2046.0b4.exe</location></product></locations>
21:20:23     INFO - Checking if Firefox-46.0b4-stub already exists
21:20:23     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b4-stub', None), kwargs: {}, attempt #1
21:20:23     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b4-stub
21:20:23     INFO - Server response
21:20:23     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
21:20:23     INFO - Products found: 0
21:20:23     INFO - Adding stub-installer...
21:20:23     INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b4-stub', 'ssl_only': 'true'}), kwargs: {}, attempt #1
21:20:23     INFO - POST data: product=Firefox-46.0b4-stub&ssl_only=true
21:20:23     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
21:20:24     INFO - Server response
21:20:24     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="5358" name="Firefox-46.0b4-stub"/></products>
21:20:24     INFO - Adding paths...
21:20:24     INFO - win32 (win): /firefox/releases/46.0b4/win32/:lang/Firefox%20Setup%20Stub%2046.0b4.exe
21:20:24     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/win32/:lang/Firefox%20Setup%20Stub%2046.0b4.exe', 'product': u'Firefox-46.0b4-stub', 'os': 'win'}), kwargs: {}, attempt #1
21:20:24     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fwin32%2F%3Alang%2FFirefox%2520Setup%2520Stub%252046.0b4.exe&product=Firefox-46.0b4-stub&os=win
21:20:24     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:24     INFO - Server response
21:20:24     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5358" name="Firefox-46.0b4-stub"><location id="27122" os="win">/firefox/releases/46.0b4/win32/:lang/Firefox%20Setup%20Stub%2046.0b4.exe</location></product></locations>
21:20:24     INFO - win64 (win64): /firefox/releases/46.0b4/win64/:lang/Firefox%20Setup%20Stub%2046.0b4.exe
21:20:24     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/win64/:lang/Firefox%20Setup%20Stub%2046.0b4.exe', 'product': u'Firefox-46.0b4-stub', 'os': 'win64'}), kwargs: {}, attempt #1
21:20:24     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fwin64%2F%3Alang%2FFirefox%2520Setup%2520Stub%252046.0b4.exe&product=Firefox-46.0b4-stub&os=win64
21:20:24     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:25     INFO - Server response
21:20:25     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5358" name="Firefox-46.0b4-stub"><location id="27123" os="win64">/firefox/releases/46.0b4/win64/:lang/Firefox%20Setup%20Stub%2046.0b4.exe</location></product></locations>
21:20:25     INFO - Checking if Firefox-46.0b4-Partial-45.0b7 already exists
21:20:25     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b4-Partial-45.0b7', None), kwargs: {}, attempt #1
21:20:25     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b4-Partial-45.0b7
21:20:26     INFO - Server response
21:20:26     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
21:20:26     INFO - Products found: 0
21:20:26     INFO - Adding partial updates for Firefox-46.0b4-Partial-45.0b7
21:20:26     INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b4-Partial-45.0b7'}), kwargs: {}, attempt #1
21:20:26     INFO - POST data: product=Firefox-46.0b4-Partial-45.0b7
21:20:26     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
21:20:26     INFO - Server response
21:20:26     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="5359" name="Firefox-46.0b4-Partial-45.0b7"/></products>
21:20:26     INFO - linux (linux): /firefox/releases/46.0b4/update/linux-i686/:lang/firefox-45.0b7-46.0b4.partial.mar
21:20:26     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/linux-i686/:lang/firefox-45.0b7-46.0b4.partial.mar', 'product': u'Firefox-46.0b4-Partial-45.0b7', 'os': 'linux'}), kwargs: {}, attempt #1
21:20:26     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-45.0b7-46.0b4.partial.mar&product=Firefox-46.0b4-Partial-45.0b7&os=linux
21:20:26     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:27     INFO - Server response
21:20:27     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5359" name="Firefox-46.0b4-Partial-45.0b7"><location id="27124" os="linux">/firefox/releases/46.0b4/update/linux-i686/:lang/firefox-45.0b7-46.0b4.partial.mar</location></product></locations>
21:20:27     INFO - linux64 (linux64): /firefox/releases/46.0b4/update/linux-x86_64/:lang/firefox-45.0b7-46.0b4.partial.mar
21:20:27     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/linux-x86_64/:lang/firefox-45.0b7-46.0b4.partial.mar', 'product': u'Firefox-46.0b4-Partial-45.0b7', 'os': 'linux64'}), kwargs: {}, attempt #1
21:20:27     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-45.0b7-46.0b4.partial.mar&product=Firefox-46.0b4-Partial-45.0b7&os=linux64
21:20:27     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:27     INFO - Server response
21:20:27     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5359" name="Firefox-46.0b4-Partial-45.0b7"><location id="27125" os="linux64">/firefox/releases/46.0b4/update/linux-x86_64/:lang/firefox-45.0b7-46.0b4.partial.mar</location></product></locations>
21:20:27     INFO - macosx64 (osx): /firefox/releases/46.0b4/update/mac/:lang/firefox-45.0b7-46.0b4.partial.mar
21:20:27     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/mac/:lang/firefox-45.0b7-46.0b4.partial.mar', 'product': u'Firefox-46.0b4-Partial-45.0b7', 'os': 'osx'}), kwargs: {}, attempt #1
21:20:27     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-45.0b7-46.0b4.partial.mar&product=Firefox-46.0b4-Partial-45.0b7&os=osx
21:20:27     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:28     INFO - Server response
21:20:28     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5359" name="Firefox-46.0b4-Partial-45.0b7"><location id="27126" os="osx">/firefox/releases/46.0b4/update/mac/:lang/firefox-45.0b7-46.0b4.partial.mar</location></product></locations>
21:20:28     INFO - win32 (win): /firefox/releases/46.0b4/update/win32/:lang/firefox-45.0b7-46.0b4.partial.mar
21:20:28     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/win32/:lang/firefox-45.0b7-46.0b4.partial.mar', 'product': u'Firefox-46.0b4-Partial-45.0b7', 'os': 'win'}), kwargs: {}, attempt #1
21:20:28     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-45.0b7-46.0b4.partial.mar&product=Firefox-46.0b4-Partial-45.0b7&os=win
21:20:28     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:28     INFO - Server response
21:20:28     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5359" name="Firefox-46.0b4-Partial-45.0b7"><location id="27127" os="win">/firefox/releases/46.0b4/update/win32/:lang/firefox-45.0b7-46.0b4.partial.mar</location></product></locations>
21:20:28     INFO - win64 (win64): /firefox/releases/46.0b4/update/win64/:lang/firefox-45.0b7-46.0b4.partial.mar
21:20:28     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/win64/:lang/firefox-45.0b7-46.0b4.partial.mar', 'product': u'Firefox-46.0b4-Partial-45.0b7', 'os': 'win64'}), kwargs: {}, attempt #1
21:20:28     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-45.0b7-46.0b4.partial.mar&product=Firefox-46.0b4-Partial-45.0b7&os=win64
21:20:28     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:29     INFO - Server response
21:20:29     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5359" name="Firefox-46.0b4-Partial-45.0b7"><location id="27128" os="win64">/firefox/releases/46.0b4/update/win64/:lang/firefox-45.0b7-46.0b4.partial.mar</location></product></locations>
21:20:29     INFO - Checking if Firefox-46.0b4-Partial-45.0b8 already exists
21:20:29     INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b4-Partial-45.0b8', None), kwargs: {}, attempt #1
21:20:29     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b4-Partial-45.0b8
21:20:30     INFO - Server response
21:20:30     INFO - <?xml version="1.0" encoding="utf-8"?><products/>
21:20:30     INFO - Products found: 0
21:20:30     INFO - Adding partial updates for Firefox-46.0b4-Partial-45.0b8
21:20:30     INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b4-Partial-45.0b8'}), kwargs: {}, attempt #1
21:20:30     INFO - POST data: product=Firefox-46.0b4-Partial-45.0b8
21:20:30     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
21:20:30     INFO - Server response
21:20:30     INFO - <?xml version="1.0" encoding="utf-8"?><products><product id="5360" name="Firefox-46.0b4-Partial-45.0b8"/></products>
21:20:30     INFO - linux (linux): /firefox/releases/46.0b4/update/linux-i686/:lang/firefox-45.0b8-46.0b4.partial.mar
21:20:30     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/linux-i686/:lang/firefox-45.0b8-46.0b4.partial.mar', 'product': u'Firefox-46.0b4-Partial-45.0b8', 'os': 'linux'}), kwargs: {}, attempt #1
21:20:30     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-45.0b8-46.0b4.partial.mar&product=Firefox-46.0b4-Partial-45.0b8&os=linux
21:20:30     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:31     INFO - Server response
21:20:31     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5360" name="Firefox-46.0b4-Partial-45.0b8"><location id="27129" os="linux">/firefox/releases/46.0b4/update/linux-i686/:lang/firefox-45.0b8-46.0b4.partial.mar</location></product></locations>
21:20:31     INFO - linux64 (linux64): /firefox/releases/46.0b4/update/linux-x86_64/:lang/firefox-45.0b8-46.0b4.partial.mar
21:20:31     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/linux-x86_64/:lang/firefox-45.0b8-46.0b4.partial.mar', 'product': u'Firefox-46.0b4-Partial-45.0b8', 'os': 'linux64'}), kwargs: {}, attempt #1
21:20:31     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-45.0b8-46.0b4.partial.mar&product=Firefox-46.0b4-Partial-45.0b8&os=linux64
21:20:31     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:31     INFO - Server response
21:20:31     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5360" name="Firefox-46.0b4-Partial-45.0b8"><location id="27130" os="linux64">/firefox/releases/46.0b4/update/linux-x86_64/:lang/firefox-45.0b8-46.0b4.partial.mar</location></product></locations>
21:20:31     INFO - macosx64 (osx): /firefox/releases/46.0b4/update/mac/:lang/firefox-45.0b8-46.0b4.partial.mar
21:20:31     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/mac/:lang/firefox-45.0b8-46.0b4.partial.mar', 'product': u'Firefox-46.0b4-Partial-45.0b8', 'os': 'osx'}), kwargs: {}, attempt #1
21:20:31     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-45.0b8-46.0b4.partial.mar&product=Firefox-46.0b4-Partial-45.0b8&os=osx
21:20:31     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:32     INFO - Server response
21:20:32     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5360" name="Firefox-46.0b4-Partial-45.0b8"><location id="27131" os="osx">/firefox/releases/46.0b4/update/mac/:lang/firefox-45.0b8-46.0b4.partial.mar</location></product></locations>
21:20:32     INFO - win32 (win): /firefox/releases/46.0b4/update/win32/:lang/firefox-45.0b8-46.0b4.partial.mar
21:20:32     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/win32/:lang/firefox-45.0b8-46.0b4.partial.mar', 'product': u'Firefox-46.0b4-Partial-45.0b8', 'os': 'win'}), kwargs: {}, attempt #1
21:20:32     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-45.0b8-46.0b4.partial.mar&product=Firefox-46.0b4-Partial-45.0b8&os=win
21:20:32     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:33     INFO - Server response
21:20:33     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5360" name="Firefox-46.0b4-Partial-45.0b8"><location id="27132" os="win">/firefox/releases/46.0b4/update/win32/:lang/firefox-45.0b8-46.0b4.partial.mar</location></product></locations>
21:20:33     INFO - win64 (win64): /firefox/releases/46.0b4/update/win64/:lang/firefox-45.0b8-46.0b4.partial.mar
21:20:33     INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b4/update/win64/:lang/firefox-45.0b8-46.0b4.partial.mar', 'product': u'Firefox-46.0b4-Partial-45.0b8', 'os': 'win64'}), kwargs: {}, attempt #1
21:20:33     INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b4%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-45.0b8-46.0b4.partial.mar&product=Firefox-46.0b4-Partial-45.0b8&os=win64
21:20:33     INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
21:20:33     INFO - Server response
21:20:33     INFO - <?xml version="1.0" encoding="utf-8"?><locations><product id="5360" name="Firefox-46.0b4-Partial-45.0b8"><location id="27133" os="win64">/firefox/releases/46.0b4/update/win64/:lang/firefox-45.0b8-46.0b4.partial.mar</location></product></locations>
21:20:33     INFO - Running post-run listener: copy_logs_to_upload_dir
21:20:33     INFO - Copying logs to upload dir...
21:20:33     INFO - mkdir: /builds/slave/rel-date_fx_bncr_sub-000000000/build/upload/logs
21:20:33     INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=23.043338
========= master_lag: 0.02 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 23 secs) (at 2016-03-07 21:20:33.716580) =========

========= Started no change (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:33.719281) =========
bash -c 'for file in `ls -1`; do cat $file; done'
 in dir /builds/slave/rel-date_fx_bncr_sub-000000000/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-426.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-date_fx_bncr_sub-000000000/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.004874

========= master_lag: 0.04 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:33.766750) =========

========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:33.767074) =========
rm -f oauth.txt
 in dir /builds/slave/rel-date_fx_bncr_sub-000000000/. (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-426.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-date_fx_bncr_sub-000000000
  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.002744
========= master_lag: 0.04 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 21:20:33.813583) =========

========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 21:20:33.813910) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 21:20:33.814170) =========

========= Total master_lag: 0.28 =========