builder: release-date_firefox_bncr_sub
slave: bld-linux64-spot-561
starttime: 1457231087.31
results: success (0)
revision: e1da13e006f645900a95c2f8a64fe4968b0d50b2
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.315116) =========
master: http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.315555) =========
========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.315869) =========
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-561.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.003737
basedir: '/builds/slave/rel-date_fx_bncr_sub-000000000'
========= master_lag: 0.01 =========
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.334035) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.334310) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.345246) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.345641) =========
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-561.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.002487
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.391108) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.391376) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.391702) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.392003) =========
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-561.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-05 18:24:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12141 (12K) [text/x-python]
Saving to: ‘archiver_client.py’
0K .......... . 100% 97.0M=0s
2016-03-05 18:24:47 (97.0 MB/s) - ‘archiver_client.py’ saved [12141/12141]
program finished with exit code 0
elapsedTime=0.204003
========= master_lag: 0.07 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.663065) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.663351) =========
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-561.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.002380
========= master_lag: 0.01 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.676201) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:47.676512) =========
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-561.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-05 18:24:47,727 truncating revision to first 12 chars
2016-03-05 18:24:47,727 Setting DEBUG logging.
2016-03-05 18:24:47,727 attempt 1/10
2016-03-05 18:24:47,727 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-05 18:24:47,992 unpacking tar archive at: date-e1da13e006f6/testing/mozharness/
program finished with exit code 0
elapsedTime=0.419072
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:48.107790) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:48.108155) =========
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-561.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.002723
script_repo_revision: 'e1da13e006f645900a95c2f8a64fe4968b0d50b2'
========= master_lag: 0.05 =========
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:48.157818) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:48.158150) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-05 18:24:48.167474) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 24 secs) (at 2016-03-05 18:24:48.167746) =========
/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-561.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
18:24:48 INFO - MultiFileLogger online at 20160305 18:24:48 in /builds/slave/rel-date_fx_bncr_sub-000000000
18:24:48 INFO - Using buildbot properties:
18:24:48 INFO - {
18:24:48 INFO - "project": "",
18:24:48 INFO - "product": "firefox",
18:24:48 INFO - "build_number": 1,
18:24:48 INFO - "taskId": "srj5BrBNQiyzL9ZR_WJwUA",
18:24:48 INFO - "repository": "",
18:24:48 INFO - "buildername": "release-date_firefox_bncr_sub",
18:24:48 INFO - "basedir": "/builds/slave/rel-date_fx_bncr_sub-000000000",
18:24:48 INFO - "buildnumber": 16,
18:24:48 INFO - "slavename": "bld-linux64-spot-561",
18:24:48 INFO - "version": "46.0b3",
18:24:48 INFO - "release_promotion": true,
18:24:48 INFO - "platform": null,
18:24:48 INFO - "branch": "releases/date",
18:24:48 INFO - "script_repo_revision": "e1da13e006f645900a95c2f8a64fe4968b0d50b2",
18:24:48 INFO - "master": "http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/",
18:24:48 INFO - "revision": "e1da13e006f645900a95c2f8a64fe4968b0d50b2",
18:24:48 INFO - "partial_versions": "45.0b7build1, 45.0b8build1",
18:24:48 INFO - "repo_path": "projects/date"
18:24:48 INFO - }
18:24:48 INFO - Overriding product with firefox
18:24:48 INFO - Overriding version with 46.0b3
18:24:48 INFO - Overriding build_number with 1
18:24:48 INFO - Overriding revision with e1da13e006f645900a95c2f8a64fe4968b0d50b2
18:24:48 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
18:24:48 INFO - Dumping config to /builds/slave/rel-date_fx_bncr_sub-000000000/logs/localconfig.json.
18:24:48 INFO - {'append_to_log': False,
18:24:48 INFO - 'base_work_dir': '/builds/slave/rel-date_fx_bncr_sub-000000000',
18:24:48 INFO - 'bouncer-api-prefix': 'https://admin-bouncer.stage.mozaws.net/api',
18:24:48 INFO - 'build_number': 1,
18:24:48 INFO - 'buildbot_json_path': 'buildprops.json',
18:24:48 INFO - 'config_files': ('releases/bouncer_firefox_date.py',),
18:24:48 INFO - 'credentials_file': 'oauth.txt',
18:24:48 INFO - 'log_level': 'info',
18:24:48 INFO - 'log_to_console': True,
18:24:48 INFO - 'opt_config_files': (),
18:24:48 INFO - 'partials': {'releases-dir': {'add-locales': False,
18:24:48 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
18:24:48 INFO - 'linux64': {'bouncer-platform': 'linux64',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
18:24:48 INFO - 'macosx64': {'bouncer-platform': 'osx',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
18:24:48 INFO - 'win32': {'bouncer-platform': 'win',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
18:24:48 INFO - 'win64': {'bouncer-platform': 'win64',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
18:24:48 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s',
18:24:48 INFO - 'ssl-only': False}},
18:24:48 INFO - 'prev_versions': (u'45.0b7build1', u'45.0b8build1'),
18:24:48 INFO - 'product': u'firefox',
18:24:48 INFO - 'products': {'complete-mar': {'add-locales': False,
18:24:48 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
18:24:48 INFO - 'linux64': {'bouncer-platform': 'linux64',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
18:24:48 INFO - 'macosx64': {'bouncer-platform': 'osx',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
18:24:48 INFO - 'win32': {'bouncer-platform': 'win',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
18:24:48 INFO - 'win64': {'bouncer-platform': 'win64',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
18:24:48 INFO - 'product-name': 'Firefox-%(version)s-Complete',
18:24:48 INFO - 'ssl-only': False},
18:24:48 INFO - 'installer': {'add-locales': False,
18:24:48 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
18:24:48 INFO - 'linux64': {'bouncer-platform': 'linux64',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
18:24:48 INFO - 'macosx64': {'bouncer-platform': 'osx',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
18:24:48 INFO - 'win32': {'bouncer-platform': 'win',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
18:24:48 INFO - 'win64': {'bouncer-platform': 'win64',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
18:24:48 INFO - 'product-name': 'Firefox-%(version)s',
18:24:48 INFO - 'ssl-only': False},
18:24:48 INFO - 'installer-ssl': {'add-locales': False,
18:24:48 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
18:24:48 INFO - 'linux64': {'bouncer-platform': 'linux64',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
18:24:48 INFO - 'macosx64': {'bouncer-platform': 'osx',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
18:24:48 INFO - 'win32': {'bouncer-platform': 'win',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
18:24:48 INFO - 'win64': {'bouncer-platform': 'win64',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
18:24:48 INFO - 'product-name': 'Firefox-%(version)s-SSL',
18:24:48 INFO - 'ssl-only': True},
18:24:48 INFO - 'stub-installer': {'add-locales': False,
18:24:48 INFO - 'paths': {'win32': {'bouncer-platform': 'win',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'},
18:24:48 INFO - 'win64': {'bouncer-platform': 'win64',
18:24:48 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}},
18:24:48 INFO - 'product-name': 'Firefox-%(version)s-stub',
18:24:48 INFO - 'ssl-only': True}},
18:24:48 INFO - 'repo': 'projects/date',
18:24:48 INFO - 'revision': u'e1da13e006f645900a95c2f8a64fe4968b0d50b2',
18:24:48 INFO - 'version': u'46.0b3',
18:24:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
18:24:48 INFO - 'work_dir': 'build'}
18:24:48 INFO - #####
18:24:48 INFO - ##### Running clobber step.
18:24:48 INFO - #####
18:24:48 INFO - Running main action method: clobber
18:24:48 INFO - rmtree: /builds/slave/rel-date_fx_bncr_sub-000000000/build
18:24:48 INFO - #####
18:24:48 INFO - ##### Running download-shipped-locales step.
18:24:48 INFO - #####
18:24:48 INFO - Running main action method: download_shipped_locales
18:24:48 INFO - No need to download shipped-locales
18:24:48 INFO - #####
18:24:48 INFO - ##### Running submit step.
18:24:48 INFO - #####
18:24:48 INFO - Running main action method: submit
18:24:48 INFO - Checking if Firefox-46.0b3-Complete already exists
18:24:48 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b3-Complete', None), kwargs: {}, attempt #1
18:24:48 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b3-Complete
18:24:49 INFO - Server response
18:24:49 INFO -
18:24:49 INFO - Products found: 0
18:24:49 INFO - Adding complete-mar...
18:24:49 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b3-Complete'}), kwargs: {}, attempt #1
18:24:49 INFO - POST data: product=Firefox-46.0b3-Complete
18:24:49 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
18:24:49 INFO - Server response
18:24:49 INFO -
18:24:49 INFO - Adding paths...
18:24:49 INFO - linux (linux): /firefox/releases/46.0b3/update/linux-i686/:lang/firefox-46.0b3.complete.mar
18:24:49 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/linux-i686/:lang/firefox-46.0b3.complete.mar', 'product': u'Firefox-46.0b3-Complete', 'os': 'linux'}), kwargs: {}, attempt #1
18:24:49 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-46.0b3.complete.mar&product=Firefox-46.0b3-Complete&os=linux
18:24:49 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:50 INFO - Server response
18:24:50 INFO - /firefox/releases/46.0b3/update/linux-i686/:lang/firefox-46.0b3.complete.mar
18:24:50 INFO - linux64 (linux64): /firefox/releases/46.0b3/update/linux-x86_64/:lang/firefox-46.0b3.complete.mar
18:24:50 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/linux-x86_64/:lang/firefox-46.0b3.complete.mar', 'product': u'Firefox-46.0b3-Complete', 'os': 'linux64'}), kwargs: {}, attempt #1
18:24:50 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-46.0b3.complete.mar&product=Firefox-46.0b3-Complete&os=linux64
18:24:50 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:50 INFO - Server response
18:24:50 INFO - /firefox/releases/46.0b3/update/linux-x86_64/:lang/firefox-46.0b3.complete.mar
18:24:50 INFO - macosx64 (osx): /firefox/releases/46.0b3/update/mac/:lang/firefox-46.0b3.complete.mar
18:24:50 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/mac/:lang/firefox-46.0b3.complete.mar', 'product': u'Firefox-46.0b3-Complete', 'os': 'osx'}), kwargs: {}, attempt #1
18:24:50 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-46.0b3.complete.mar&product=Firefox-46.0b3-Complete&os=osx
18:24:50 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:51 INFO - Server response
18:24:51 INFO - /firefox/releases/46.0b3/update/mac/:lang/firefox-46.0b3.complete.mar
18:24:51 INFO - win32 (win): /firefox/releases/46.0b3/update/win32/:lang/firefox-46.0b3.complete.mar
18:24:51 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/win32/:lang/firefox-46.0b3.complete.mar', 'product': u'Firefox-46.0b3-Complete', 'os': 'win'}), kwargs: {}, attempt #1
18:24:51 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-46.0b3.complete.mar&product=Firefox-46.0b3-Complete&os=win
18:24:51 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:52 INFO - Server response
18:24:52 INFO - /firefox/releases/46.0b3/update/win32/:lang/firefox-46.0b3.complete.mar
18:24:52 INFO - win64 (win64): /firefox/releases/46.0b3/update/win64/:lang/firefox-46.0b3.complete.mar
18:24:52 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/win64/:lang/firefox-46.0b3.complete.mar', 'product': u'Firefox-46.0b3-Complete', 'os': 'win64'}), kwargs: {}, attempt #1
18:24:52 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-46.0b3.complete.mar&product=Firefox-46.0b3-Complete&os=win64
18:24:52 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:52 INFO - Server response
18:24:52 INFO - /firefox/releases/46.0b3/update/win64/:lang/firefox-46.0b3.complete.mar
18:24:52 INFO - Checking if Firefox-46.0b3 already exists
18:24:52 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b3', None), kwargs: {}, attempt #1
18:24:52 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b3
18:24:53 INFO - Server response
18:24:53 INFO -
18:24:53 INFO - Products found: 0
18:24:53 INFO - Adding installer...
18:24:53 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b3'}), kwargs: {}, attempt #1
18:24:53 INFO - POST data: product=Firefox-46.0b3
18:24:53 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
18:24:53 INFO - Server response
18:24:53 INFO -
18:24:53 INFO - Adding paths...
18:24:53 INFO - linux (linux): /firefox/releases/46.0b3/linux-i686/:lang/firefox-46.0b3.tar.bz2
18:24:53 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/linux-i686/:lang/firefox-46.0b3.tar.bz2', 'product': u'Firefox-46.0b3', 'os': 'linux'}), kwargs: {}, attempt #1
18:24:53 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Flinux-i686%2F%3Alang%2Ffirefox-46.0b3.tar.bz2&product=Firefox-46.0b3&os=linux
18:24:53 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:54 INFO - Server response
18:24:54 INFO - /firefox/releases/46.0b3/linux-i686/:lang/firefox-46.0b3.tar.bz2
18:24:54 INFO - linux64 (linux64): /firefox/releases/46.0b3/linux-x86_64/:lang/firefox-46.0b3.tar.bz2
18:24:54 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/linux-x86_64/:lang/firefox-46.0b3.tar.bz2', 'product': u'Firefox-46.0b3', 'os': 'linux64'}), kwargs: {}, attempt #1
18:24:54 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Flinux-x86_64%2F%3Alang%2Ffirefox-46.0b3.tar.bz2&product=Firefox-46.0b3&os=linux64
18:24:54 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:54 INFO - Server response
18:24:54 INFO - /firefox/releases/46.0b3/linux-x86_64/:lang/firefox-46.0b3.tar.bz2
18:24:54 INFO - macosx64 (osx): /firefox/releases/46.0b3/mac/:lang/Firefox%2046.0b3.dmg
18:24:54 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/mac/:lang/Firefox%2046.0b3.dmg', 'product': u'Firefox-46.0b3', 'os': 'osx'}), kwargs: {}, attempt #1
18:24:54 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fmac%2F%3Alang%2FFirefox%252046.0b3.dmg&product=Firefox-46.0b3&os=osx
18:24:54 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:55 INFO - Server response
18:24:55 INFO - /firefox/releases/46.0b3/mac/:lang/Firefox%2046.0b3.dmg
18:24:55 INFO - win32 (win): /firefox/releases/46.0b3/win32/:lang/Firefox%20Setup%2046.0b3.exe
18:24:55 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/win32/:lang/Firefox%20Setup%2046.0b3.exe', 'product': u'Firefox-46.0b3', 'os': 'win'}), kwargs: {}, attempt #1
18:24:55 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fwin32%2F%3Alang%2FFirefox%2520Setup%252046.0b3.exe&product=Firefox-46.0b3&os=win
18:24:55 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:56 INFO - Server response
18:24:56 INFO - /firefox/releases/46.0b3/win32/:lang/Firefox%20Setup%2046.0b3.exe
18:24:56 INFO - win64 (win64): /firefox/releases/46.0b3/win64/:lang/Firefox%20Setup%2046.0b3.exe
18:24:56 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/win64/:lang/Firefox%20Setup%2046.0b3.exe', 'product': u'Firefox-46.0b3', 'os': 'win64'}), kwargs: {}, attempt #1
18:24:56 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fwin64%2F%3Alang%2FFirefox%2520Setup%252046.0b3.exe&product=Firefox-46.0b3&os=win64
18:24:56 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:56 INFO - Server response
18:24:56 INFO - /firefox/releases/46.0b3/win64/:lang/Firefox%20Setup%2046.0b3.exe
18:24:56 INFO - Checking if Firefox-46.0b3-SSL already exists
18:24:56 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b3-SSL', None), kwargs: {}, attempt #1
18:24:56 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b3-SSL
18:24:57 INFO - Server response
18:24:57 INFO -
18:24:57 INFO - Products found: 0
18:24:57 INFO - Adding installer-ssl...
18:24:57 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b3-SSL', 'ssl_only': 'true'}), kwargs: {}, attempt #1
18:24:57 INFO - POST data: product=Firefox-46.0b3-SSL&ssl_only=true
18:24:57 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
18:24:57 INFO - Server response
18:24:57 INFO -
18:24:57 INFO - Adding paths...
18:24:57 INFO - linux (linux): /firefox/releases/46.0b3/linux-i686/:lang/firefox-46.0b3.tar.bz2
18:24:57 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/linux-i686/:lang/firefox-46.0b3.tar.bz2', 'product': u'Firefox-46.0b3-SSL', 'os': 'linux'}), kwargs: {}, attempt #1
18:24:57 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Flinux-i686%2F%3Alang%2Ffirefox-46.0b3.tar.bz2&product=Firefox-46.0b3-SSL&os=linux
18:24:57 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:58 INFO - Server response
18:24:58 INFO - /firefox/releases/46.0b3/linux-i686/:lang/firefox-46.0b3.tar.bz2
18:24:58 INFO - linux64 (linux64): /firefox/releases/46.0b3/linux-x86_64/:lang/firefox-46.0b3.tar.bz2
18:24:58 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/linux-x86_64/:lang/firefox-46.0b3.tar.bz2', 'product': u'Firefox-46.0b3-SSL', 'os': 'linux64'}), kwargs: {}, attempt #1
18:24:58 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Flinux-x86_64%2F%3Alang%2Ffirefox-46.0b3.tar.bz2&product=Firefox-46.0b3-SSL&os=linux64
18:24:58 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:59 INFO - Server response
18:24:59 INFO - /firefox/releases/46.0b3/linux-x86_64/:lang/firefox-46.0b3.tar.bz2
18:24:59 INFO - macosx64 (osx): /firefox/releases/46.0b3/mac/:lang/Firefox%2046.0b3.dmg
18:24:59 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/mac/:lang/Firefox%2046.0b3.dmg', 'product': u'Firefox-46.0b3-SSL', 'os': 'osx'}), kwargs: {}, attempt #1
18:24:59 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fmac%2F%3Alang%2FFirefox%252046.0b3.dmg&product=Firefox-46.0b3-SSL&os=osx
18:24:59 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:24:59 INFO - Server response
18:24:59 INFO - /firefox/releases/46.0b3/mac/:lang/Firefox%2046.0b3.dmg
18:24:59 INFO - win32 (win): /firefox/releases/46.0b3/win32/:lang/Firefox%20Setup%2046.0b3.exe
18:24:59 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/win32/:lang/Firefox%20Setup%2046.0b3.exe', 'product': u'Firefox-46.0b3-SSL', 'os': 'win'}), kwargs: {}, attempt #1
18:24:59 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fwin32%2F%3Alang%2FFirefox%2520Setup%252046.0b3.exe&product=Firefox-46.0b3-SSL&os=win
18:24:59 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:00 INFO - Server response
18:25:00 INFO - /firefox/releases/46.0b3/win32/:lang/Firefox%20Setup%2046.0b3.exe
18:25:00 INFO - win64 (win64): /firefox/releases/46.0b3/win64/:lang/Firefox%20Setup%2046.0b3.exe
18:25:00 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/win64/:lang/Firefox%20Setup%2046.0b3.exe', 'product': u'Firefox-46.0b3-SSL', 'os': 'win64'}), kwargs: {}, attempt #1
18:25:00 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fwin64%2F%3Alang%2FFirefox%2520Setup%252046.0b3.exe&product=Firefox-46.0b3-SSL&os=win64
18:25:00 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:01 INFO - Server response
18:25:01 INFO - /firefox/releases/46.0b3/win64/:lang/Firefox%20Setup%2046.0b3.exe
18:25:01 INFO - Checking if Firefox-46.0b3-stub already exists
18:25:01 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b3-stub', None), kwargs: {}, attempt #1
18:25:01 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b3-stub
18:25:02 INFO - Server response
18:25:02 INFO -
18:25:02 INFO - Products found: 0
18:25:02 INFO - Adding stub-installer...
18:25:02 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b3-stub', 'ssl_only': 'true'}), kwargs: {}, attempt #1
18:25:02 INFO - POST data: product=Firefox-46.0b3-stub&ssl_only=true
18:25:02 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
18:25:02 INFO - Server response
18:25:02 INFO -
18:25:02 INFO - Adding paths...
18:25:02 INFO - win32 (win): /firefox/releases/46.0b3/win32/:lang/Firefox%20Setup%20Stub%2046.0b3.exe
18:25:02 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/win32/:lang/Firefox%20Setup%20Stub%2046.0b3.exe', 'product': u'Firefox-46.0b3-stub', 'os': 'win'}), kwargs: {}, attempt #1
18:25:02 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fwin32%2F%3Alang%2FFirefox%2520Setup%2520Stub%252046.0b3.exe&product=Firefox-46.0b3-stub&os=win
18:25:02 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:03 INFO - Server response
18:25:03 INFO - /firefox/releases/46.0b3/win32/:lang/Firefox%20Setup%20Stub%2046.0b3.exe
18:25:03 INFO - win64 (win64): /firefox/releases/46.0b3/win64/:lang/Firefox%20Setup%20Stub%2046.0b3.exe
18:25:03 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/win64/:lang/Firefox%20Setup%20Stub%2046.0b3.exe', 'product': u'Firefox-46.0b3-stub', 'os': 'win64'}), kwargs: {}, attempt #1
18:25:03 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fwin64%2F%3Alang%2FFirefox%2520Setup%2520Stub%252046.0b3.exe&product=Firefox-46.0b3-stub&os=win64
18:25:03 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:04 INFO - Server response
18:25:04 INFO - /firefox/releases/46.0b3/win64/:lang/Firefox%20Setup%20Stub%2046.0b3.exe
18:25:04 INFO - Checking if Firefox-46.0b3-Partial-45.0b7 already exists
18:25:04 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b3-Partial-45.0b7', None), kwargs: {}, attempt #1
18:25:04 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b3-Partial-45.0b7
18:25:04 INFO - Server response
18:25:04 INFO -
18:25:04 INFO - Products found: 0
18:25:04 INFO - Adding partial updates for Firefox-46.0b3-Partial-45.0b7
18:25:04 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b3-Partial-45.0b7'}), kwargs: {}, attempt #1
18:25:04 INFO - POST data: product=Firefox-46.0b3-Partial-45.0b7
18:25:04 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
18:25:05 INFO - Server response
18:25:05 INFO -
18:25:05 INFO - linux (linux): /firefox/releases/46.0b3/update/linux-i686/:lang/firefox-45.0b7-46.0b3.partial.mar
18:25:05 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/linux-i686/:lang/firefox-45.0b7-46.0b3.partial.mar', 'product': u'Firefox-46.0b3-Partial-45.0b7', 'os': 'linux'}), kwargs: {}, attempt #1
18:25:05 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-45.0b7-46.0b3.partial.mar&product=Firefox-46.0b3-Partial-45.0b7&os=linux
18:25:05 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:06 INFO - Server response
18:25:06 INFO - /firefox/releases/46.0b3/update/linux-i686/:lang/firefox-45.0b7-46.0b3.partial.mar
18:25:06 INFO - linux64 (linux64): /firefox/releases/46.0b3/update/linux-x86_64/:lang/firefox-45.0b7-46.0b3.partial.mar
18:25:06 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/linux-x86_64/:lang/firefox-45.0b7-46.0b3.partial.mar', 'product': u'Firefox-46.0b3-Partial-45.0b7', 'os': 'linux64'}), kwargs: {}, attempt #1
18:25:06 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-45.0b7-46.0b3.partial.mar&product=Firefox-46.0b3-Partial-45.0b7&os=linux64
18:25:06 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:06 INFO - Server response
18:25:06 INFO - /firefox/releases/46.0b3/update/linux-x86_64/:lang/firefox-45.0b7-46.0b3.partial.mar
18:25:06 INFO - macosx64 (osx): /firefox/releases/46.0b3/update/mac/:lang/firefox-45.0b7-46.0b3.partial.mar
18:25:06 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/mac/:lang/firefox-45.0b7-46.0b3.partial.mar', 'product': u'Firefox-46.0b3-Partial-45.0b7', 'os': 'osx'}), kwargs: {}, attempt #1
18:25:06 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-45.0b7-46.0b3.partial.mar&product=Firefox-46.0b3-Partial-45.0b7&os=osx
18:25:06 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:07 INFO - Server response
18:25:07 INFO - /firefox/releases/46.0b3/update/mac/:lang/firefox-45.0b7-46.0b3.partial.mar
18:25:07 INFO - win32 (win): /firefox/releases/46.0b3/update/win32/:lang/firefox-45.0b7-46.0b3.partial.mar
18:25:07 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/win32/:lang/firefox-45.0b7-46.0b3.partial.mar', 'product': u'Firefox-46.0b3-Partial-45.0b7', 'os': 'win'}), kwargs: {}, attempt #1
18:25:07 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-45.0b7-46.0b3.partial.mar&product=Firefox-46.0b3-Partial-45.0b7&os=win
18:25:07 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:07 INFO - Server response
18:25:07 INFO - /firefox/releases/46.0b3/update/win32/:lang/firefox-45.0b7-46.0b3.partial.mar
18:25:07 INFO - win64 (win64): /firefox/releases/46.0b3/update/win64/:lang/firefox-45.0b7-46.0b3.partial.mar
18:25:07 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/win64/:lang/firefox-45.0b7-46.0b3.partial.mar', 'product': u'Firefox-46.0b3-Partial-45.0b7', 'os': 'win64'}), kwargs: {}, attempt #1
18:25:07 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-45.0b7-46.0b3.partial.mar&product=Firefox-46.0b3-Partial-45.0b7&os=win64
18:25:07 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:08 INFO - Server response
18:25:08 INFO - /firefox/releases/46.0b3/update/win64/:lang/firefox-45.0b7-46.0b3.partial.mar
18:25:08 INFO - Checking if Firefox-46.0b3-Partial-45.0b8 already exists
18:25:08 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0b3-Partial-45.0b8', None), kwargs: {}, attempt #1
18:25:08 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0b3-Partial-45.0b8
18:25:09 INFO - Server response
18:25:09 INFO -
18:25:09 INFO - Products found: 0
18:25:09 INFO - Adding partial updates for Firefox-46.0b3-Partial-45.0b8
18:25:09 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0b3-Partial-45.0b8'}), kwargs: {}, attempt #1
18:25:09 INFO - POST data: product=Firefox-46.0b3-Partial-45.0b8
18:25:09 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
18:25:09 INFO - Server response
18:25:09 INFO -
18:25:09 INFO - linux (linux): /firefox/releases/46.0b3/update/linux-i686/:lang/firefox-45.0b8-46.0b3.partial.mar
18:25:09 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/linux-i686/:lang/firefox-45.0b8-46.0b3.partial.mar', 'product': u'Firefox-46.0b3-Partial-45.0b8', 'os': 'linux'}), kwargs: {}, attempt #1
18:25:09 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-45.0b8-46.0b3.partial.mar&product=Firefox-46.0b3-Partial-45.0b8&os=linux
18:25:09 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:10 INFO - Server response
18:25:10 INFO - /firefox/releases/46.0b3/update/linux-i686/:lang/firefox-45.0b8-46.0b3.partial.mar
18:25:10 INFO - linux64 (linux64): /firefox/releases/46.0b3/update/linux-x86_64/:lang/firefox-45.0b8-46.0b3.partial.mar
18:25:10 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/linux-x86_64/:lang/firefox-45.0b8-46.0b3.partial.mar', 'product': u'Firefox-46.0b3-Partial-45.0b8', 'os': 'linux64'}), kwargs: {}, attempt #1
18:25:10 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-45.0b8-46.0b3.partial.mar&product=Firefox-46.0b3-Partial-45.0b8&os=linux64
18:25:10 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:10 INFO - Server response
18:25:10 INFO - /firefox/releases/46.0b3/update/linux-x86_64/:lang/firefox-45.0b8-46.0b3.partial.mar
18:25:10 INFO - macosx64 (osx): /firefox/releases/46.0b3/update/mac/:lang/firefox-45.0b8-46.0b3.partial.mar
18:25:10 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/mac/:lang/firefox-45.0b8-46.0b3.partial.mar', 'product': u'Firefox-46.0b3-Partial-45.0b8', 'os': 'osx'}), kwargs: {}, attempt #1
18:25:10 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-45.0b8-46.0b3.partial.mar&product=Firefox-46.0b3-Partial-45.0b8&os=osx
18:25:10 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:11 INFO - Server response
18:25:11 INFO - /firefox/releases/46.0b3/update/mac/:lang/firefox-45.0b8-46.0b3.partial.mar
18:25:11 INFO - win32 (win): /firefox/releases/46.0b3/update/win32/:lang/firefox-45.0b8-46.0b3.partial.mar
18:25:11 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/win32/:lang/firefox-45.0b8-46.0b3.partial.mar', 'product': u'Firefox-46.0b3-Partial-45.0b8', 'os': 'win'}), kwargs: {}, attempt #1
18:25:11 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-45.0b8-46.0b3.partial.mar&product=Firefox-46.0b3-Partial-45.0b8&os=win
18:25:11 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:12 INFO - Server response
18:25:12 INFO - /firefox/releases/46.0b3/update/win32/:lang/firefox-45.0b8-46.0b3.partial.mar
18:25:12 INFO - win64 (win64): /firefox/releases/46.0b3/update/win64/:lang/firefox-45.0b8-46.0b3.partial.mar
18:25:12 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/releases/46.0b3/update/win64/:lang/firefox-45.0b8-46.0b3.partial.mar', 'product': u'Firefox-46.0b3-Partial-45.0b8', 'os': 'win64'}), kwargs: {}, attempt #1
18:25:12 INFO - POST data: path=%2Ffirefox%2Freleases%2F46.0b3%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-45.0b8-46.0b3.partial.mar&product=Firefox-46.0b3-Partial-45.0b8&os=win64
18:25:12 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
18:25:12 INFO - Server response
18:25:12 INFO - /firefox/releases/46.0b3/update/win64/:lang/firefox-45.0b8-46.0b3.partial.mar
18:25:12 INFO - Running post-run listener: copy_logs_to_upload_dir
18:25:12 INFO - Copying logs to upload dir...
18:25:12 INFO - mkdir: /builds/slave/rel-date_fx_bncr_sub-000000000/build/upload/logs
18:25:12 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=24.545026
========= master_lag: 0.02 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 24 secs) (at 2016-03-05 18:25:12.730182) =========
========= Started no change (results: 0, elapsed: 0 secs) (at 2016-03-05 18:25:12.732828) =========
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-561.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.004521
========= master_lag: 0.05 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2016-03-05 18:25:12.785854) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 18:25:12.786167) =========
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-561.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.002457
========= master_lag: 0.04 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 18:25:12.832466) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-05 18:25:12.832772) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-05 18:25:12.833062) =========
========= Total master_lag: 0.30 =========