builder: release-birch_firefox_bncr_sub
slave: bld-linux64-spot-301
starttime: 1517257694.23
results: success (0)
revision: 084dccaa2410585cfe89f8542fb9e6eff62fafe0
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2018-01-29 12:28:14.231414) =========
master: http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2018-01-29 12:28:14.231825) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-01-29 12:28:14.232107) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-01-29 12:28:14.290790) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-01-29 12:28:14.291060) =========
bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'
in dir /builds/slave/rel-bir_fx_bncr_sub-0000000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-301.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-bir_fx_bncr_sub-0000000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
--2018-01-29 12:28:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: ‘archiver_client.py’
0K .......... . 100% 129M=0s
2018-01-29 12:28:14 (129 MB/s) - ‘archiver_client.py’ saved [12179/12179]
program finished with exit code 0
elapsedTime=0.223628
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-01-29 12:28:14.525879) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-01-29 12:28:14.526172) =========
rm -rf scripts properties
in dir /builds/slave/rel-bir_fx_bncr_sub-0000000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'scripts', 'properties']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-301.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-bir_fx_bncr_sub-0000000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.003362
========= master_lag: 0.05 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-01-29 12:28:14.574793) =========
========= Started 'bash -c ...' (results: 0, elapsed: 2 mins, 2 secs) (at 2018-01-29 12:28:14.575103) =========
bash -c 'python archiver_client.py mozharness --repo projects/birch --rev 084dccaa2410585cfe89f8542fb9e6eff62fafe0 --destination scripts --debug'
in dir /builds/slave/rel-bir_fx_bncr_sub-0000000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/birch --rev 084dccaa2410585cfe89f8542fb9e6eff62fafe0 --destination scripts --debug']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-301.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-bir_fx_bncr_sub-0000000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
2018-01-29 12:28:14,626 truncating revision to first 12 chars
2018-01-29 12:28:14,626 Setting DEBUG logging.
2018-01-29 12:28:14,626 attempt 1/10
2018-01-29 12:28:14,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/birch/084dccaa2410?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2018-01-29 12:28:15,300 attempt 1/10
2018-01-29 12:28:15,949 current task status: no status available at this point. state: PENDING
2018-01-29 12:28:15,950 sleeping for 9.00s (attempt 1/10)
2018-01-29 12:28:24,959 attempt 2/10
2018-01-29 12:28:25,606 current task status: no status available at this point. state: PENDING
2018-01-29 12:28:25,606 sleeping for 13.50s (attempt 2/10)
2018-01-29 12:28:39,120 attempt 3/10
2018-01-29 12:28:39,739 current task status: no status available at this point. state: PENDING
2018-01-29 12:28:39,740 sleeping for 19.25s (attempt 3/10)
2018-01-29 12:28:59,009 attempt 4/10
2018-01-29 12:28:59,651 current task status: no status available at this point. state: PENDING
2018-01-29 12:28:59,651 sleeping for 29.88s (attempt 4/10)
2018-01-29 12:29:29,556 attempt 5/10
2018-01-29 12:29:30,549 current task status: Task has expired from pending for too long. Re-creating task. state: RETRY
2018-01-29 12:29:30,549 sleeping for 45.81s (attempt 5/10)
2018-01-29 12:30:16,408 attempt 6/10
2018-01-29 12:30:16,934 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS
2018-01-29 12:30:16,996 unpacking tar archive at: birch-084dccaa2410/testing/mozharness/
program finished with exit code 0
elapsedTime=122.578265
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 mins, 2 secs) (at 2018-01-29 12:30:17.162915) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-01-29 12:30:17.163246) =========
script_repo_revision: 084dccaa2410585cfe89f8542fb9e6eff62fafe0
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-01-29 12:30:17.163635) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-01-29 12:30:17.163912) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-01-29 12:30:17.174128) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 15 secs) (at 2018-01-29 12:30:17.174404) =========
/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_release.py --credentials-file oauth.txt --bouncer-api-prefix https://admin-bouncer-releng.stage.mozaws.net/api --repo projects/birch
in dir /builds/slave/rel-bir_fx_bncr_sub-0000000000/. (timeout 3600 secs) (maxTime 14400 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', 'scripts/scripts/bouncer_submitter.py', '-c', 'releases/bouncer_firefox_release.py', '--credentials-file', 'oauth.txt', '--bouncer-api-prefix', 'https://admin-bouncer-releng.stage.mozaws.net/api', '--repo', 'projects/birch']
environment:
CCACHE_COMPRESS=1
CCACHE_DIR=/builds/ccache
CCACHE_HASHDIR=
CCACHE_UMASK=002
DISPLAY=:2
G_BROKEN_FILENAMES=1
HG_SHARE_BASE_DIR=/builds/hg-shared
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-301.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LC_ALL=C
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
MOZ_AUTOMATION=1
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_OBJDIR=obj-firefox
PATH=/tools/buildbot/bin:/usr/local/bin:/usr/lib64/ccache:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/tools/git/bin:/tools/python27/bin:/tools/python27-mercurial/bin:/home/cltbld/bin
PROPERTIES_FILE=/builds/slave/rel-bir_fx_bncr_sub-0000000000/buildprops.json
PWD=/builds/slave/rel-bir_fx_bncr_sub-0000000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TINDERBOX_OUTPUT=1
TMOUT=86400
TOOLTOOL_CACHE=/builds/tooltool_cache
TOOLTOOL_HOME=/builds
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
12:30:17 INFO - MultiFileLogger online at 20180129 12:30:17 in /builds/slave/rel-bir_fx_bncr_sub-0000000000
12:30:17 INFO - Using buildbot properties:
12:30:17 INFO - {
12:30:17 INFO - "project": "",
12:30:17 INFO - "product": "firefox",
12:30:17 INFO - "build_number": 4,
12:30:17 INFO - "taskId": "DXUn_2OASnGeI4lBRUmd8w",
12:30:17 INFO - "repository": "https://hg.mozilla.org/projects/birch",
12:30:17 INFO - "buildername": "release-birch_firefox_bncr_sub",
12:30:17 INFO - "balrog_api_root": "https://balrog-admin.stage.mozaws.net/api",
12:30:17 INFO - "basedir": "/builds/slave/rel-bir_fx_bncr_sub-0000000000",
12:30:17 INFO - "appVersion": "['60.0.2']",
12:30:17 INFO - "buildnumber": 1,
12:30:17 INFO - "platform": null,
12:30:17 INFO - "version": "60.0.2",
12:30:17 INFO - "release_promotion": true,
12:30:17 INFO - "script_repo_revision": "084dccaa2410585cfe89f8542fb9e6eff62fafe0",
12:30:17 INFO - "branch": "birch",
12:30:17 INFO - "master": "http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/",
12:30:17 INFO - "revision": "084dccaa2410585cfe89f8542fb9e6eff62fafe0",
12:30:17 INFO - "slavename": "bld-linux64-spot-301",
12:30:17 INFO - "next_version": "60.0.3",
12:30:17 INFO - "repo_path": "projects/birch"
12:30:17 INFO - }
12:30:17 INFO - Overriding product with firefox
12:30:17 INFO - Overriding version with 60.0.2
12:30:17 INFO - Overriding build_number with 4
12:30:17 INFO - Overriding revision with 084dccaa2410585cfe89f8542fb9e6eff62fafe0
12:30:17 INFO - Run as scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_release.py --credentials-file oauth.txt --bouncer-api-prefix https://admin-bouncer-releng.stage.mozaws.net/api --repo projects/birch
12:30:17 INFO - Dumping config to /builds/slave/rel-bir_fx_bncr_sub-0000000000/logs/localconfig.json.
12:30:17 INFO - {'append_to_log': False,
12:30:17 INFO - 'base_work_dir': '/builds/slave/rel-bir_fx_bncr_sub-0000000000',
12:30:17 INFO - 'bouncer-api-prefix': 'https://admin-bouncer-releng.stage.mozaws.net/api',
12:30:17 INFO - 'build_number': 4,
12:30:17 INFO - 'buildbot_json_path': 'buildprops.json',
12:30:17 INFO - 'config_files': ('releases/bouncer_firefox_release.py',),
12:30:17 INFO - 'credentials_file': 'oauth.txt',
12:30:17 INFO - 'log_level': 'info',
12:30:17 INFO - 'log_to_console': True,
12:30:17 INFO - 'opt_config_files': (),
12:30:17 INFO - 'partials': {'candidates-dir': {'add-locales': True,
12:30:17 INFO - 'check_uptake': False,
12:30:17 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:30:17 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:30:17 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:30:17 INFO - 'win32': {'bouncer-platform': 'win',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:30:17 INFO - 'win64': {'bouncer-platform': 'win64',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
12:30:17 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Partial-%(prev_version)sbuild%(prev_build_number)s',
12:30:17 INFO - 'ssl-only': False},
12:30:17 INFO - 'releases-dir': {'add-locales': True,
12:30:17 INFO - 'check_uptake': True,
12:30:17 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:30:17 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:30:17 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:30:17 INFO - 'win32': {'bouncer-platform': 'win',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:30:17 INFO - 'win64': {'bouncer-platform': 'win64',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
12:30:17 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s',
12:30:17 INFO - 'ssl-only': False}},
12:30:17 INFO - 'product': u'firefox',
12:30:17 INFO - 'products': {'complete-mar': {'add-locales': True,
12:30:17 INFO - 'check_uptake': True,
12:30:17 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
12:30:17 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
12:30:17 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
12:30:17 INFO - 'win32': {'bouncer-platform': 'win',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
12:30:17 INFO - 'win64': {'bouncer-platform': 'win64',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
12:30:17 INFO - 'product-name': 'Firefox-%(version)s-Complete',
12:30:17 INFO - 'ssl-only': False},
12:30:17 INFO - 'complete-mar-bz2': {'add-locales': True,
12:30:17 INFO - 'check_uptake': True,
12:30:17 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.bz2.complete.mar'},
12:30:17 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.bz2.complete.mar'},
12:30:17 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.bz2.complete.mar'},
12:30:17 INFO - 'win32': {'bouncer-platform': 'win',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.bz2.complete.mar'},
12:30:17 INFO - 'win64': {'bouncer-platform': 'win64',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.bz2.complete.mar'}},
12:30:17 INFO - 'product-name': 'Firefox-%(version)s-Complete-bz2',
12:30:17 INFO - 'ssl-only': False},
12:30:17 INFO - 'complete-mar-candidates': {'add-locales': True,
12:30:17 INFO - 'check_uptake': False,
12:30:17 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
12:30:17 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
12:30:17 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
12:30:17 INFO - 'win32': {'bouncer-platform': 'win',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
12:30:17 INFO - 'win64': {'bouncer-platform': 'win64',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
12:30:17 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete',
12:30:17 INFO - 'ssl-only': False},
12:30:17 INFO - 'complete-mar-candidates-bz2': {'add-locales': True,
12:30:17 INFO - 'check_uptake': False,
12:30:17 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.bz2.complete.mar'},
12:30:17 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.bz2.complete.mar'},
12:30:17 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.bz2.complete.mar'},
12:30:17 INFO - 'win32': {'bouncer-platform': 'win',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.bz2.complete.mar'},
12:30:17 INFO - 'win64': {'bouncer-platform': 'win64',
12:30:17 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.bz2.complete.mar'}},
12:30:17 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete-bz2',
12:30:17 INFO - 'ssl-only': False},
12:30:17 INFO - 'installer': {'add-locales': True,
12:30:17 INFO - 'alias': 'firefox-latest',
12:30:17 INFO - 'check_uptake': True,
12:30:17 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
12:30:17 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
12:30:17 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
12:30:17 INFO - 'win32': {'bouncer-platform': 'win',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
12:30:17 INFO - 'win64': {'bouncer-platform': 'win64',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
12:30:17 INFO - 'product-name': 'Firefox-%(version)s',
12:30:17 INFO - 'ssl-only': False},
12:30:17 INFO - 'installer-ssl': {'add-locales': True,
12:30:17 INFO - 'alias': 'firefox-latest-ssl',
12:30:17 INFO - 'check_uptake': True,
12:30:17 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
12:30:17 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
12:30:17 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
12:30:17 INFO - 'win32': {'bouncer-platform': 'win',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
12:30:17 INFO - 'win64': {'bouncer-platform': 'win64',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
12:30:17 INFO - 'product-name': 'Firefox-%(version)s-SSL',
12:30:17 INFO - 'ssl-only': True},
12:30:17 INFO - 'stub-installer': {'add-locales': True,
12:30:17 INFO - 'alias': 'firefox-stub',
12:30:17 INFO - 'check_uptake': True,
12:30:17 INFO - 'paths': {'win32': {'bouncer-platform': 'win',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'},
12:30:17 INFO - 'win64': {'bouncer-platform': 'win64',
12:30:17 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}},
12:30:17 INFO - 'product-name': 'Firefox-%(version)s-stub',
12:30:17 INFO - 'ssl-only': True}},
12:30:17 INFO - 'repo': 'projects/birch',
12:30:17 INFO - 'revision': u'084dccaa2410585cfe89f8542fb9e6eff62fafe0',
12:30:17 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales',
12:30:17 INFO - 'version': u'60.0.2',
12:30:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
12:30:17 INFO - 'work_dir': 'build'}
12:30:17 INFO - [mozharness: 2018-01-29 20:30:17.381354Z] Running clobber step.
12:30:17 INFO - Running main action method: clobber
12:30:17 INFO - rmtree: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build
12:30:17 INFO - [mozharness: 2018-01-29 20:30:17.384632Z] Finished clobber step (success)
12:30:17 INFO - [mozharness: 2018-01-29 20:30:17.384963Z] Running download-shipped-locales step.
12:30:17 INFO - Running main action method: download_shipped_locales
12:30:17 INFO - mkdir: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build
12:30:17 INFO - Downloading https://hg.mozilla.org/projects/birch/raw-file/084dccaa2410585cfe89f8542fb9e6eff62fafe0/browser/locales/shipped-locales to /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales
12:30:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://hg.mozilla.org/projects/birch/raw-file/084dccaa2410585cfe89f8542fb9e6eff62fafe0/browser/locales/shipped-locales', 'file_name': '/builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales'}, attempt #1
12:30:18 INFO - Downloaded 395 bytes.
12:30:18 INFO - Reading from file /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/shipped-locales
12:30:18 INFO - Contents:
12:30:18 INFO - ach
12:30:18 INFO - af
12:30:18 INFO - an
12:30:18 INFO - ar
12:30:18 INFO - as
12:30:18 INFO - ast
12:30:18 INFO - az
12:30:18 INFO - be
12:30:18 INFO - bg
12:30:18 INFO - bn-BD
12:30:18 INFO - bn-IN
12:30:18 INFO - br
12:30:18 INFO - bs
12:30:18 INFO - ca
12:30:18 INFO - cak
12:30:18 INFO - cs
12:30:18 INFO - cy
12:30:18 INFO - da
12:30:18 INFO - de
12:30:18 INFO - dsb
12:30:18 INFO - el
12:30:18 INFO - en-GB
12:30:18 INFO - en-US
12:30:18 INFO - en-ZA
12:30:18 INFO - eo
12:30:18 INFO - es-AR
12:30:18 INFO - es-CL
12:30:18 INFO - es-ES
12:30:18 INFO - es-MX
12:30:18 INFO - et
12:30:18 INFO - eu
12:30:18 INFO - fa
12:30:18 INFO - ff
12:30:18 INFO - fi
12:30:18 INFO - fr
12:30:18 INFO - fy-NL
12:30:18 INFO - ga-IE
12:30:18 INFO - gd
12:30:18 INFO - gl
12:30:18 INFO - gn
12:30:18 INFO - gu-IN
12:30:18 INFO - he
12:30:18 INFO - hi-IN
12:30:18 INFO - hr
12:30:18 INFO - hsb
12:30:18 INFO - hu
12:30:18 INFO - hy-AM
12:30:18 INFO - ia
12:30:18 INFO - id
12:30:18 INFO - is
12:30:18 INFO - it
12:30:18 INFO - ja linux win32
12:30:18 INFO - ja-JP-mac osx
12:30:18 INFO - ka
12:30:18 INFO - kab
12:30:18 INFO - kk
12:30:18 INFO - km
12:30:18 INFO - kn
12:30:18 INFO - ko
12:30:18 INFO - lij
12:30:18 INFO - lt
12:30:18 INFO - lv
12:30:18 INFO - mai
12:30:18 INFO - mk
12:30:18 INFO - ml
12:30:18 INFO - mr
12:30:18 INFO - ms
12:30:18 INFO - my
12:30:18 INFO - nb-NO
12:30:18 INFO - ne-NP
12:30:18 INFO - nl
12:30:18 INFO - nn-NO
12:30:18 INFO - or
12:30:18 INFO - pa-IN
12:30:18 INFO - pl
12:30:18 INFO - pt-BR
12:30:18 INFO - pt-PT
12:30:18 INFO - rm
12:30:18 INFO - ro
12:30:18 INFO - ru
12:30:18 INFO - si
12:30:18 INFO - sk
12:30:18 INFO - sl
12:30:18 INFO - son
12:30:18 INFO - sq
12:30:18 INFO - sr
12:30:18 INFO - sv-SE
12:30:18 INFO - ta
12:30:18 INFO - te
12:30:18 INFO - th
12:30:18 INFO - tr
12:30:18 INFO - uk
12:30:18 INFO - ur
12:30:18 INFO - uz
12:30:18 INFO - vi
12:30:18 INFO - xh
12:30:18 INFO - zh-CN
12:30:18 INFO - zh-TW
12:30:18 INFO - [mozharness: 2018-01-29 20:30:18.703567Z] Finished download-shipped-locales step (success)
12:30:18 INFO - [mozharness: 2018-01-29 20:30:18.703761Z] Running submit step.
12:30:18 INFO - Running main action method: submit
12:30:18 INFO - Checking if Firefox-60.0.2-Complete already exists
12:30:18 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-60.0.2-Complete', None), kwargs: {}, attempt #1
12:30:18 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-60.0.2-Complete
12:30:19 INFO - Server response
12:30:19 INFO -
12:30:19 INFO - Products found: 1
12:30:19 WARNING - Product Firefox-60.0.2-Complete already exists. Skipping...
12:30:19 INFO - Checking if Firefox-60.0.2-Complete-bz2 already exists
12:30:19 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-60.0.2-Complete-bz2', None), kwargs: {}, attempt #1
12:30:19 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-60.0.2-Complete-bz2
12:30:20 INFO - Server response
12:30:20 INFO -
12:30:20 INFO - Products found: 1
12:30:20 WARNING - Product Firefox-60.0.2-Complete-bz2 already exists. Skipping...
12:30:20 INFO - Checking if Firefox-60.0.2build4-Complete already exists
12:30:20 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-60.0.2build4-Complete', None), kwargs: {}, attempt #1
12:30:20 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-60.0.2build4-Complete
12:30:20 INFO - Server response
12:30:20 INFO -
12:30:20 INFO - Products found: 0
12:30:20 INFO - Adding complete-mar-candidates...
12:30:20 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['ach', 'af', 'an', 'ar', 'as', 'ast', 'az', 'be', 'bg', 'bn-BD', 'bn-IN', 'br', 'bs', 'ca', 'cak', 'cs', 'cy', 'da', 'de', 'dsb', 'el', 'en-GB', 'en-US', 'en-ZA', 'eo', 'es-AR', 'es-CL', 'es-ES', 'es-MX', 'et', 'eu', 'fa', 'ff', 'fi', 'fr', 'fy-NL', 'ga-IE', 'gd', 'gl', 'gn', 'gu-IN', 'he', 'hi-IN', 'hr', 'hsb', 'hu', 'hy-AM', 'ia', 'id', 'is', 'it', 'ja', 'ja-JP-mac', 'ka', 'kab', 'kk', 'km', 'kn', 'ko', 'lij', 'lt', 'lv', 'mai', 'mk', 'ml', 'mr', 'ms', 'my', 'nb-NO', 'ne-NP', 'nl', 'nn-NO', 'or', 'pa-IN', 'pl', 'pt-BR', 'pt-PT', 'rm', 'ro', 'ru', 'si', 'sk', 'sl', 'son', 'sq', 'sr', 'sv-SE', 'ta', 'te', 'th', 'tr', 'uk', 'ur', 'uz', 'vi', 'xh', 'zh-CN', 'zh-TW'], 'product': u'Firefox-60.0.2build4-Complete'}), kwargs: {}, attempt #1
12:30:20 INFO - POST data: languages=ach&languages=af&languages=an&languages=ar&languages=as&languages=ast&languages=az&languages=be&languages=bg&languages=bn-BD&languages=bn-IN&languages=br&languages=bs&languages=ca&languages=cak&languages=cs&languages=cy&languages=da&languages=de&languages=dsb&languages=el&languages=en-GB&languages=en-US&languages=en-ZA&languages=eo&languages=es-AR&languages=es-CL&languages=es-ES&languages=es-MX&languages=et&languages=eu&languages=fa&languages=ff&languages=fi&languages=fr&languages=fy-NL&languages=ga-IE&languages=gd&languages=gl&languages=gn&languages=gu-IN&languages=he&languages=hi-IN&languages=hr&languages=hsb&languages=hu&languages=hy-AM&languages=ia&languages=id&languages=is&languages=it&languages=ja&languages=ja-JP-mac&languages=ka&languages=kab&languages=kk&languages=km&languages=kn&languages=ko&languages=lij&languages=lt&languages=lv&languages=mai&languages=mk&languages=ml&languages=mr&languages=ms&languages=my&languages=nb-NO&languages=ne-NP&languages=nl&languages=nn-NO&languages=or&languages=pa-IN&languages=pl&languages=pt-BR&languages=pt-PT&languages=rm&languages=ro&languages=ru&languages=si&languages=sk&languages=sl&languages=son&languages=sq&languages=sr&languages=sv-SE&languages=ta&languages=te&languages=th&languages=tr&languages=uk&languages=ur&languages=uz&languages=vi&languages=xh&languages=zh-CN&languages=zh-TW&product=Firefox-60.0.2build4-Complete
12:30:20 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
12:30:22 INFO - Server response
12:30:22 INFO -
12:30:22 INFO - Adding paths...
12:30:22 INFO - linux (linux): /firefox/candidates/60.0.2-candidates/build4/update/linux-i686/:lang/firefox-60.0.2.complete.mar
12:30:22 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/60.0.2-candidates/build4/update/linux-i686/:lang/firefox-60.0.2.complete.mar', 'product': u'Firefox-60.0.2build4-Complete', 'os': 'linux'}), kwargs: {}, attempt #1
12:30:22 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F60.0.2-candidates%2Fbuild4%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-60.0.2.complete.mar&product=Firefox-60.0.2build4-Complete&os=linux
12:30:22 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
12:30:23 INFO - Server response
12:30:23 INFO - /firefox/candidates/60.0.2-candidates/build4/update/linux-i686/:lang/firefox-60.0.2.complete.mar
12:30:23 INFO - linux64 (linux64): /firefox/candidates/60.0.2-candidates/build4/update/linux-x86_64/:lang/firefox-60.0.2.complete.mar
12:30:23 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/60.0.2-candidates/build4/update/linux-x86_64/:lang/firefox-60.0.2.complete.mar', 'product': u'Firefox-60.0.2build4-Complete', 'os': 'linux64'}), kwargs: {}, attempt #1
12:30:23 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F60.0.2-candidates%2Fbuild4%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-60.0.2.complete.mar&product=Firefox-60.0.2build4-Complete&os=linux64
12:30:23 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
12:30:23 INFO - Server response
12:30:23 INFO - /firefox/candidates/60.0.2-candidates/build4/update/linux-x86_64/:lang/firefox-60.0.2.complete.mar
12:30:23 INFO - macosx64 (osx): /firefox/candidates/60.0.2-candidates/build4/update/mac/:lang/firefox-60.0.2.complete.mar
12:30:23 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/60.0.2-candidates/build4/update/mac/:lang/firefox-60.0.2.complete.mar', 'product': u'Firefox-60.0.2build4-Complete', 'os': 'osx'}), kwargs: {}, attempt #1
12:30:23 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F60.0.2-candidates%2Fbuild4%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-60.0.2.complete.mar&product=Firefox-60.0.2build4-Complete&os=osx
12:30:23 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
12:30:24 INFO - Server response
12:30:24 INFO - /firefox/candidates/60.0.2-candidates/build4/update/mac/:lang/firefox-60.0.2.complete.mar
12:30:24 INFO - win32 (win): /firefox/candidates/60.0.2-candidates/build4/update/win32/:lang/firefox-60.0.2.complete.mar
12:30:24 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/60.0.2-candidates/build4/update/win32/:lang/firefox-60.0.2.complete.mar', 'product': u'Firefox-60.0.2build4-Complete', 'os': 'win'}), kwargs: {}, attempt #1
12:30:24 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F60.0.2-candidates%2Fbuild4%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-60.0.2.complete.mar&product=Firefox-60.0.2build4-Complete&os=win
12:30:24 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
12:30:25 INFO - Server response
12:30:25 INFO - /firefox/candidates/60.0.2-candidates/build4/update/win32/:lang/firefox-60.0.2.complete.mar
12:30:25 INFO - win64 (win64): /firefox/candidates/60.0.2-candidates/build4/update/win64/:lang/firefox-60.0.2.complete.mar
12:30:25 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/60.0.2-candidates/build4/update/win64/:lang/firefox-60.0.2.complete.mar', 'product': u'Firefox-60.0.2build4-Complete', 'os': 'win64'}), kwargs: {}, attempt #1
12:30:25 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F60.0.2-candidates%2Fbuild4%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-60.0.2.complete.mar&product=Firefox-60.0.2build4-Complete&os=win64
12:30:25 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
12:30:25 INFO - Server response
12:30:25 INFO - /firefox/candidates/60.0.2-candidates/build4/update/win64/:lang/firefox-60.0.2.complete.mar
12:30:25 INFO - Checking if Firefox-60.0.2build4-Complete-bz2 already exists
12:30:25 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-60.0.2build4-Complete-bz2', None), kwargs: {}, attempt #1
12:30:25 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-60.0.2build4-Complete-bz2
12:30:26 INFO - Server response
12:30:26 INFO -
12:30:26 INFO - Products found: 0
12:30:26 INFO - Adding complete-mar-candidates-bz2...
12:30:26 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['ach', 'af', 'an', 'ar', 'as', 'ast', 'az', 'be', 'bg', 'bn-BD', 'bn-IN', 'br', 'bs', 'ca', 'cak', 'cs', 'cy', 'da', 'de', 'dsb', 'el', 'en-GB', 'en-US', 'en-ZA', 'eo', 'es-AR', 'es-CL', 'es-ES', 'es-MX', 'et', 'eu', 'fa', 'ff', 'fi', 'fr', 'fy-NL', 'ga-IE', 'gd', 'gl', 'gn', 'gu-IN', 'he', 'hi-IN', 'hr', 'hsb', 'hu', 'hy-AM', 'ia', 'id', 'is', 'it', 'ja', 'ja-JP-mac', 'ka', 'kab', 'kk', 'km', 'kn', 'ko', 'lij', 'lt', 'lv', 'mai', 'mk', 'ml', 'mr', 'ms', 'my', 'nb-NO', 'ne-NP', 'nl', 'nn-NO', 'or', 'pa-IN', 'pl', 'pt-BR', 'pt-PT', 'rm', 'ro', 'ru', 'si', 'sk', 'sl', 'son', 'sq', 'sr', 'sv-SE', 'ta', 'te', 'th', 'tr', 'uk', 'ur', 'uz', 'vi', 'xh', 'zh-CN', 'zh-TW'], 'product': u'Firefox-60.0.2build4-Complete-bz2'}), kwargs: {}, attempt #1
12:30:26 INFO - POST data: languages=ach&languages=af&languages=an&languages=ar&languages=as&languages=ast&languages=az&languages=be&languages=bg&languages=bn-BD&languages=bn-IN&languages=br&languages=bs&languages=ca&languages=cak&languages=cs&languages=cy&languages=da&languages=de&languages=dsb&languages=el&languages=en-GB&languages=en-US&languages=en-ZA&languages=eo&languages=es-AR&languages=es-CL&languages=es-ES&languages=es-MX&languages=et&languages=eu&languages=fa&languages=ff&languages=fi&languages=fr&languages=fy-NL&languages=ga-IE&languages=gd&languages=gl&languages=gn&languages=gu-IN&languages=he&languages=hi-IN&languages=hr&languages=hsb&languages=hu&languages=hy-AM&languages=ia&languages=id&languages=is&languages=it&languages=ja&languages=ja-JP-mac&languages=ka&languages=kab&languages=kk&languages=km&languages=kn&languages=ko&languages=lij&languages=lt&languages=lv&languages=mai&languages=mk&languages=ml&languages=mr&languages=ms&languages=my&languages=nb-NO&languages=ne-NP&languages=nl&languages=nn-NO&languages=or&languages=pa-IN&languages=pl&languages=pt-BR&languages=pt-PT&languages=rm&languages=ro&languages=ru&languages=si&languages=sk&languages=sl&languages=son&languages=sq&languages=sr&languages=sv-SE&languages=ta&languages=te&languages=th&languages=tr&languages=uk&languages=ur&languages=uz&languages=vi&languages=xh&languages=zh-CN&languages=zh-TW&product=Firefox-60.0.2build4-Complete-bz2
12:30:26 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/
12:30:28 INFO - Server response
12:30:28 INFO -
12:30:28 INFO - Adding paths...
12:30:28 INFO - linux (linux): /firefox/candidates/60.0.2-candidates/build4/update/linux-i686/:lang/firefox-60.0.2.bz2.complete.mar
12:30:28 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/60.0.2-candidates/build4/update/linux-i686/:lang/firefox-60.0.2.bz2.complete.mar', 'product': u'Firefox-60.0.2build4-Complete-bz2', 'os': 'linux'}), kwargs: {}, attempt #1
12:30:28 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F60.0.2-candidates%2Fbuild4%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-60.0.2.bz2.complete.mar&product=Firefox-60.0.2build4-Complete-bz2&os=linux
12:30:28 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
12:30:28 INFO - Server response
12:30:28 INFO - /firefox/candidates/60.0.2-candidates/build4/update/linux-i686/:lang/firefox-60.0.2.bz2.complete.mar
12:30:28 INFO - linux64 (linux64): /firefox/candidates/60.0.2-candidates/build4/update/linux-x86_64/:lang/firefox-60.0.2.bz2.complete.mar
12:30:28 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/60.0.2-candidates/build4/update/linux-x86_64/:lang/firefox-60.0.2.bz2.complete.mar', 'product': u'Firefox-60.0.2build4-Complete-bz2', 'os': 'linux64'}), kwargs: {}, attempt #1
12:30:28 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F60.0.2-candidates%2Fbuild4%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-60.0.2.bz2.complete.mar&product=Firefox-60.0.2build4-Complete-bz2&os=linux64
12:30:28 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
12:30:29 INFO - Server response
12:30:29 INFO - /firefox/candidates/60.0.2-candidates/build4/update/linux-x86_64/:lang/firefox-60.0.2.bz2.complete.mar
12:30:29 INFO - macosx64 (osx): /firefox/candidates/60.0.2-candidates/build4/update/mac/:lang/firefox-60.0.2.bz2.complete.mar
12:30:29 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/60.0.2-candidates/build4/update/mac/:lang/firefox-60.0.2.bz2.complete.mar', 'product': u'Firefox-60.0.2build4-Complete-bz2', 'os': 'osx'}), kwargs: {}, attempt #1
12:30:29 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F60.0.2-candidates%2Fbuild4%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-60.0.2.bz2.complete.mar&product=Firefox-60.0.2build4-Complete-bz2&os=osx
12:30:29 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
12:30:29 INFO - Server response
12:30:29 INFO - /firefox/candidates/60.0.2-candidates/build4/update/mac/:lang/firefox-60.0.2.bz2.complete.mar
12:30:29 INFO - win32 (win): /firefox/candidates/60.0.2-candidates/build4/update/win32/:lang/firefox-60.0.2.bz2.complete.mar
12:30:29 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/60.0.2-candidates/build4/update/win32/:lang/firefox-60.0.2.bz2.complete.mar', 'product': u'Firefox-60.0.2build4-Complete-bz2', 'os': 'win'}), kwargs: {}, attempt #1
12:30:29 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F60.0.2-candidates%2Fbuild4%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-60.0.2.bz2.complete.mar&product=Firefox-60.0.2build4-Complete-bz2&os=win
12:30:29 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
12:30:30 INFO - Server response
12:30:30 INFO - /firefox/candidates/60.0.2-candidates/build4/update/win32/:lang/firefox-60.0.2.bz2.complete.mar
12:30:30 INFO - win64 (win64): /firefox/candidates/60.0.2-candidates/build4/update/win64/:lang/firefox-60.0.2.bz2.complete.mar
12:30:30 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/60.0.2-candidates/build4/update/win64/:lang/firefox-60.0.2.bz2.complete.mar', 'product': u'Firefox-60.0.2build4-Complete-bz2', 'os': 'win64'}), kwargs: {}, attempt #1
12:30:30 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F60.0.2-candidates%2Fbuild4%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-60.0.2.bz2.complete.mar&product=Firefox-60.0.2build4-Complete-bz2&os=win64
12:30:30 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/
12:30:30 INFO - Server response
12:30:30 INFO - /firefox/candidates/60.0.2-candidates/build4/update/win64/:lang/firefox-60.0.2.bz2.complete.mar
12:30:30 INFO - Checking if Firefox-60.0.2 already exists
12:30:30 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-60.0.2', None), kwargs: {}, attempt #1
12:30:30 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-60.0.2
12:30:31 INFO - Server response
12:30:31 INFO -
12:30:31 INFO - Products found: 1
12:30:31 WARNING - Product Firefox-60.0.2 already exists. Skipping...
12:30:31 INFO - Checking if Firefox-60.0.2-SSL already exists
12:30:31 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-60.0.2-SSL', None), kwargs: {}, attempt #1
12:30:31 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-60.0.2-SSL
12:30:32 INFO - Server response
12:30:32 INFO -
12:30:32 INFO - Products found: 1
12:30:32 WARNING - Product Firefox-60.0.2-SSL already exists. Skipping...
12:30:32 INFO - Checking if Firefox-60.0.2-stub already exists
12:30:32 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-60.0.2-stub', None), kwargs: {}, attempt #1
12:30:32 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Firefox-60.0.2-stub
12:30:32 INFO - Server response
12:30:32 INFO -
12:30:32 INFO - Products found: 1
12:30:32 WARNING - Product Firefox-60.0.2-stub already exists. Skipping...
12:30:32 INFO - [mozharness: 2018-01-29 20:30:32.587208Z] Finished submit step (success)
12:30:32 INFO - Running post-run listener: copy_logs_to_upload_dir
12:30:32 INFO - Copying logs to upload dir...
12:30:32 INFO - mkdir: /builds/slave/rel-bir_fx_bncr_sub-0000000000/build/upload/logs
12:30:32 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=15.421114
========= master_lag: 0.01 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 15 secs) (at 2018-01-29 12:30:32.610425) =========
========= Started no change (results: 0, elapsed: 0 secs) (at 2018-01-29 12:30:32.613369) =========
bash -c 'for file in `ls -1`; do cat $file; done'
in dir /builds/slave/rel-bir_fx_bncr_sub-0000000000/properties (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-301.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-bir_fx_bncr_sub-0000000000/properties
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.005383
========= master_lag: 0.05 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2018-01-29 12:30:32.666370) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-01-29 12:30:32.666680) =========
rm -f oauth.txt
in dir /builds/slave/rel-bir_fx_bncr_sub-0000000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-f', 'oauth.txt']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-301.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-bir_fx_bncr_sub-0000000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.003378
========= master_lag: 0.05 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-01-29 12:30:32.715882) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2018-01-29 12:30:32.716157) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2018-01-29 12:30:32.716394) =========
========= Total master_lag: 0.17 =========