builder: release-maple_devedition_bncr_sub slave: bld-linux64-spot-326 starttime: 1518469138.69 results: success (0) revision: d09169b947dc9477c8eddee8d2d5cdac2299bb64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2018-02-12 12:58:58.694529) ========= master: http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2018-02-12 12:58:58.694959) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-02-12 12:58:58.695241) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-02-12 12:58:58.751162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-02-12 12:58:58.751650) ========= 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-map_de_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-326.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-map_de_bncr_sub-0000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False --2018-02-12 12:58:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: ‘archiver_client.py’ 0K .......... . 100% 156M=0s 2018-02-12 12:58:59 (156 MB/s) - ‘archiver_client.py’ saved [12179/12179] program finished with exit code 0 elapsedTime=0.686039 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-02-12 12:58:59.450247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-02-12 12:58:59.450564) ========= rm -rf scripts properties in dir /builds/slave/rel-map_de_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-326.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-map_de_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.003038 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-02-12 12:58:59.498000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 mins, 21 secs) (at 2018-02-12 12:58:59.498312) ========= bash -c 'python archiver_client.py mozharness --repo projects/maple --rev d09169b947dc9477c8eddee8d2d5cdac2299bb64 --destination scripts --debug' in dir /builds/slave/rel-map_de_bncr_sub-0000000000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/maple --rev d09169b947dc9477c8eddee8d2d5cdac2299bb64 --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-326.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-map_de_bncr_sub-0000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2018-02-12 12:58:59,561 truncating revision to first 12 chars 2018-02-12 12:58:59,561 Setting DEBUG logging. 2018-02-12 12:58:59,561 attempt 1/10 2018-02-12 12:58:59,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/maple/d09169b947dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2018-02-12 12:59:00,247 attempt 1/10 2018-02-12 12:59:00,859 current task status: no status available at this point. state: PENDING 2018-02-12 12:59:00,859 sleeping for 10.00s (attempt 1/10) 2018-02-12 12:59:10,870 attempt 2/10 2018-02-12 12:59:11,494 current task status: no status available at this point. state: PENDING 2018-02-12 12:59:11,494 sleeping for 16.00s (attempt 2/10) 2018-02-12 12:59:27,510 attempt 3/10 2018-02-12 12:59:28,113 current task status: no status available at this point. state: PENDING 2018-02-12 12:59:28,113 sleeping for 24.00s (attempt 3/10) 2018-02-12 12:59:52,137 attempt 4/10 2018-02-12 12:59:52,786 current task status: no status available at this point. state: PENDING 2018-02-12 12:59:52,786 sleeping for 35.00s (attempt 4/10) 2018-02-12 13:00:27,821 attempt 5/10 2018-02-12 13:00:28,823 current task status: Task has expired from pending for too long. Re-creating task. state: RETRY 2018-02-12 13:00:28,823 sleeping for 51.50s (attempt 5/10) 2018-02-12 13:01:20,375 attempt 6/10 2018-02-12 13:01:20,904 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2018-02-12 13:01:20,970 unpacking tar archive at: maple-d09169b947dc/testing/mozharness/ program finished with exit code 0 elapsedTime=141.619033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 mins, 21 secs) (at 2018-02-12 13:01:21.123594) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-02-12 13:01:21.123948) ========= script_repo_revision: d09169b947dc9477c8eddee8d2d5cdac2299bb64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-02-12 13:01:21.124379) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-02-12 13:01:21.124676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-02-12 13:01:21.130960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 9 secs) (at 2018-02-12 13:01:21.131248) ========= /tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_devedition.py --credentials-file oauth.txt --bouncer-api-prefix https://admin-bouncer-releng.stage.mozaws.net/api --repo projects/maple in dir /builds/slave/rel-map_de_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_devedition.py', '--credentials-file', 'oauth.txt', '--bouncer-api-prefix', 'https://admin-bouncer-releng.stage.mozaws.net/api', '--repo', 'projects/maple'] 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-326.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-map_de_bncr_sub-0000000000/buildprops.json PWD=/builds/slave/rel-map_de_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 13:01:21 INFO - MultiFileLogger online at 20180212 13:01:21 in /builds/slave/rel-map_de_bncr_sub-0000000000 13:01:21 INFO - Using buildbot properties: 13:01:21 INFO - { 13:01:21 INFO - "project": "", 13:01:21 INFO - "product": "devedition", 13:01:21 INFO - "build_number": 2, 13:01:21 INFO - "taskId": "SflE-fcYSrOgnG5ZHkum0A", 13:01:21 INFO - "repository": "https://hg.mozilla.org/projects/maple", 13:01:21 INFO - "buildername": "release-maple_devedition_bncr_sub", 13:01:21 INFO - "balrog_api_root": "https://balrog-admin.stage.mozaws.net/api", 13:01:21 INFO - "basedir": "/builds/slave/rel-map_de_bncr_sub-0000000000", 13:01:21 INFO - "appVersion": "59.0", 13:01:21 INFO - "buildnumber": 7, 13:01:21 INFO - "slavename": "bld-linux64-spot-326", 13:01:21 INFO - "version": "59.0b8", 13:01:21 INFO - "release_promotion": true, 13:01:21 INFO - "platform": null, 13:01:21 INFO - "branch": "maple", 13:01:21 INFO - "script_repo_revision": "d09169b947dc9477c8eddee8d2d5cdac2299bb64", 13:01:21 INFO - "master": "http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/", 13:01:21 INFO - "revision": "d09169b947dc9477c8eddee8d2d5cdac2299bb64", 13:01:21 INFO - "partial_versions": "58.0b6build1", 13:01:21 INFO - "next_version": "59.0b9", 13:01:21 INFO - "repo_path": "projects/maple" 13:01:21 INFO - } 13:01:21 INFO - Overriding product with devedition 13:01:21 INFO - Overriding version with 59.0b8 13:01:21 INFO - Overriding build_number with 2 13:01:21 INFO - Overriding revision with d09169b947dc9477c8eddee8d2d5cdac2299bb64 13:01:21 INFO - Run as scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_devedition.py --credentials-file oauth.txt --bouncer-api-prefix https://admin-bouncer-releng.stage.mozaws.net/api --repo projects/maple 13:01:21 INFO - Dumping config to /builds/slave/rel-map_de_bncr_sub-0000000000/logs/localconfig.json. 13:01:21 INFO - {'append_to_log': False, 13:01:21 INFO - 'base_work_dir': '/builds/slave/rel-map_de_bncr_sub-0000000000', 13:01:21 INFO - 'bouncer-api-prefix': 'https://admin-bouncer-releng.stage.mozaws.net/api', 13:01:21 INFO - 'bouncer_prefix': 'https://download.mozilla.org/', 13:01:21 INFO - 'build_number': 2, 13:01:21 INFO - 'buildbot_json_path': 'buildprops.json', 13:01:21 INFO - 'config_files': ('releases/bouncer_firefox_devedition.py',), 13:01:21 INFO - 'credentials_file': 'oauth.txt', 13:01:21 INFO - 'log_level': 'info', 13:01:21 INFO - 'log_to_console': True, 13:01:21 INFO - 'opt_config_files': (), 13:01:21 INFO - 'partials': {'releases-dir': {'add-locales': True, 13:01:21 INFO - 'check_uptake': True, 13:01:21 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 13:01:21 INFO - 'linux64': {'bouncer-platform': 'linux64', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 13:01:21 INFO - 'macosx64': {'bouncer-platform': 'osx', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 13:01:21 INFO - 'win32': {'bouncer-platform': 'win', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 13:01:21 INFO - 'win64': {'bouncer-platform': 'win64', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 13:01:21 INFO - 'product-name': 'Devedition-%(version)s-Partial-%(prev_version)s', 13:01:21 INFO - 'ssl-only': False}}, 13:01:21 INFO - 'prev_versions': (u'58.0b6build1',), 13:01:21 INFO - 'product': u'devedition', 13:01:21 INFO - 'products': {'complete-mar': {'add-locales': True, 13:01:21 INFO - 'check_uptake': True, 13:01:21 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 13:01:21 INFO - 'linux64': {'bouncer-platform': 'linux64', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 13:01:21 INFO - 'macosx64': {'bouncer-platform': 'osx', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 13:01:21 INFO - 'win32': {'bouncer-platform': 'win', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 13:01:21 INFO - 'win64': {'bouncer-platform': 'win64', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 13:01:21 INFO - 'product-name': 'Devedition-%(version)s-Complete', 13:01:21 INFO - 'ssl-only': False}, 13:01:21 INFO - 'installer': {'add-locales': True, 13:01:21 INFO - 'alias': 'firefox-devedition-latest', 13:01:21 INFO - 'check_uptake': True, 13:01:21 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 13:01:21 INFO - 'linux64': {'bouncer-platform': 'linux64', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 13:01:21 INFO - 'macosx64': {'bouncer-platform': 'osx', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 13:01:21 INFO - 'win32': {'bouncer-platform': 'win', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 13:01:21 INFO - 'win64': {'bouncer-platform': 'win64', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 13:01:21 INFO - 'product-name': 'Devedition-%(version)s', 13:01:21 INFO - 'ssl-only': False}, 13:01:21 INFO - 'installer-ssl': {'add-locales': True, 13:01:21 INFO - 'alias': 'firefox-devedition-latest-ssl', 13:01:21 INFO - 'check_uptake': True, 13:01:21 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 13:01:21 INFO - 'linux64': {'bouncer-platform': 'linux64', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 13:01:21 INFO - 'macosx64': {'bouncer-platform': 'osx', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 13:01:21 INFO - 'win32': {'bouncer-platform': 'win', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 13:01:21 INFO - 'win64': {'bouncer-platform': 'win64', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 13:01:21 INFO - 'product-name': 'Devedition-%(version)s-SSL', 13:01:21 INFO - 'ssl-only': True}, 13:01:21 INFO - 'stub-installer': {'add-locales': True, 13:01:21 INFO - 'alias': 'firefox-devedition-stub', 13:01:21 INFO - 'check_uptake': True, 13:01:21 INFO - 'paths': {'win32': {'bouncer-platform': 'win', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}, 13:01:21 INFO - 'win64': {'bouncer-platform': 'win64', 13:01:21 INFO - 'path': '/devedition/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}}, 13:01:21 INFO - 'product-name': 'Devedition-%(version)s-stub', 13:01:21 INFO - 'ssl-only': True}}, 13:01:21 INFO - 'repo': 'projects/maple', 13:01:21 INFO - 'revision': u'd09169b947dc9477c8eddee8d2d5cdac2299bb64', 13:01:21 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales', 13:01:21 INFO - 'version': u'59.0b8', 13:01:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:01:21 INFO - 'work_dir': 'build'} 13:01:21 INFO - [mozharness: 2018-02-12 21:01:21.565056Z] Running clobber step. 13:01:21 INFO - Running main action method: clobber 13:01:21 INFO - rmtree: /builds/slave/rel-map_de_bncr_sub-0000000000/build 13:01:21 INFO - [mozharness: 2018-02-12 21:01:21.568474Z] Finished clobber step (success) 13:01:21 INFO - [mozharness: 2018-02-12 21:01:21.568794Z] Running download-shipped-locales step. 13:01:21 INFO - Running main action method: download_shipped_locales 13:01:21 INFO - mkdir: /builds/slave/rel-map_de_bncr_sub-0000000000/build 13:01:21 INFO - Downloading https://hg.mozilla.org/projects/maple/raw-file/d09169b947dc9477c8eddee8d2d5cdac2299bb64/browser/locales/shipped-locales to /builds/slave/rel-map_de_bncr_sub-0000000000/build/shipped-locales 13:01:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://hg.mozilla.org/projects/maple/raw-file/d09169b947dc9477c8eddee8d2d5cdac2299bb64/browser/locales/shipped-locales', 'file_name': '/builds/slave/rel-map_de_bncr_sub-0000000000/build/shipped-locales'}, attempt #1 13:01:22 INFO - Downloaded 395 bytes. 13:01:22 INFO - Reading from file /builds/slave/rel-map_de_bncr_sub-0000000000/build/shipped-locales 13:01:22 INFO - Contents: 13:01:22 INFO - ach 13:01:22 INFO - af 13:01:22 INFO - an 13:01:22 INFO - ar 13:01:22 INFO - as 13:01:22 INFO - ast 13:01:22 INFO - az 13:01:22 INFO - be 13:01:22 INFO - bg 13:01:22 INFO - bn-BD 13:01:22 INFO - bn-IN 13:01:22 INFO - br 13:01:22 INFO - bs 13:01:22 INFO - ca 13:01:22 INFO - cak 13:01:22 INFO - cs 13:01:22 INFO - cy 13:01:22 INFO - da 13:01:22 INFO - de 13:01:22 INFO - dsb 13:01:22 INFO - el 13:01:22 INFO - en-GB 13:01:22 INFO - en-US 13:01:22 INFO - en-ZA 13:01:22 INFO - eo 13:01:22 INFO - es-AR 13:01:22 INFO - es-CL 13:01:22 INFO - es-ES 13:01:22 INFO - es-MX 13:01:22 INFO - et 13:01:22 INFO - eu 13:01:22 INFO - fa 13:01:22 INFO - ff 13:01:22 INFO - fi 13:01:22 INFO - fr 13:01:22 INFO - fy-NL 13:01:22 INFO - ga-IE 13:01:22 INFO - gd 13:01:22 INFO - gl 13:01:22 INFO - gn 13:01:22 INFO - gu-IN 13:01:22 INFO - he 13:01:22 INFO - hi-IN 13:01:22 INFO - hr 13:01:22 INFO - hsb 13:01:22 INFO - hu 13:01:22 INFO - hy-AM 13:01:22 INFO - ia 13:01:22 INFO - id 13:01:22 INFO - is 13:01:22 INFO - it 13:01:22 INFO - ja linux win32 13:01:22 INFO - ja-JP-mac osx 13:01:22 INFO - ka 13:01:22 INFO - kab 13:01:22 INFO - kk 13:01:22 INFO - km 13:01:22 INFO - kn 13:01:22 INFO - ko 13:01:22 INFO - lij 13:01:22 INFO - lt 13:01:22 INFO - lv 13:01:22 INFO - mai 13:01:22 INFO - mk 13:01:22 INFO - ml 13:01:22 INFO - mr 13:01:22 INFO - ms 13:01:22 INFO - my 13:01:22 INFO - nb-NO 13:01:22 INFO - ne-NP 13:01:22 INFO - nl 13:01:22 INFO - nn-NO 13:01:22 INFO - or 13:01:22 INFO - pa-IN 13:01:22 INFO - pl 13:01:22 INFO - pt-BR 13:01:22 INFO - pt-PT 13:01:22 INFO - rm 13:01:22 INFO - ro 13:01:22 INFO - ru 13:01:22 INFO - si 13:01:22 INFO - sk 13:01:22 INFO - sl 13:01:22 INFO - son 13:01:22 INFO - sq 13:01:22 INFO - sr 13:01:22 INFO - sv-SE 13:01:22 INFO - ta 13:01:22 INFO - te 13:01:22 INFO - th 13:01:22 INFO - tr 13:01:22 INFO - uk 13:01:22 INFO - ur 13:01:22 INFO - uz 13:01:22 INFO - vi 13:01:22 INFO - xh 13:01:22 INFO - zh-CN 13:01:22 INFO - zh-TW 13:01:22 INFO - [mozharness: 2018-02-12 21:01:22.784711Z] Finished download-shipped-locales step (success) 13:01:22 INFO - [mozharness: 2018-02-12 21:01:22.784933Z] Running submit step. 13:01:22 INFO - Running main action method: submit 13:01:22 INFO - Checking if Devedition-59.0b8-Complete already exists 13:01:22 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b8-Complete', None), kwargs: {}, attempt #1 13:01:22 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Devedition-59.0b8-Complete 13:01:23 INFO - Server response 13:01:23 INFO - 13:01:23 INFO - Products found: 1 13:01:23 WARNING - Product Devedition-59.0b8-Complete already exists. Skipping... 13:01:23 INFO - Checking if Devedition-59.0b8 already exists 13:01:23 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b8', None), kwargs: {}, attempt #1 13:01:23 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Devedition-59.0b8 13:01:24 INFO - Server response 13:01:24 INFO - 13:01:24 INFO - Products found: 1 13:01:24 WARNING - Product Devedition-59.0b8 already exists. Skipping... 13:01:24 INFO - Checking if Devedition-59.0b8-SSL already exists 13:01:24 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b8-SSL', None), kwargs: {}, attempt #1 13:01:24 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Devedition-59.0b8-SSL 13:01:24 INFO - Server response 13:01:24 INFO - 13:01:24 INFO - Products found: 1 13:01:24 WARNING - Product Devedition-59.0b8-SSL already exists. Skipping... 13:01:24 INFO - Checking if Devedition-59.0b8-stub already exists 13:01:24 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b8-stub', None), kwargs: {}, attempt #1 13:01:24 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Devedition-59.0b8-stub 13:01:25 INFO - Server response 13:01:25 INFO - 13:01:25 INFO - Products found: 1 13:01:25 WARNING - Product Devedition-59.0b8-stub already exists. Skipping... 13:01:25 INFO - Checking if Devedition-59.0b8-Partial-58.0b6 already exists 13:01:25 INFO - retry: Calling _api_call with args: (u'product_show?product=Devedition-59.0b8-Partial-58.0b6', None), kwargs: {}, attempt #1 13:01:25 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_show?product=Devedition-59.0b8-Partial-58.0b6 13:01:26 INFO - Server response 13:01:26 INFO - 13:01:26 INFO - Products found: 0 13:01:26 INFO - Adding partial updates for Devedition-59.0b8-Partial-58.0b6 13:01: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'Devedition-59.0b8-Partial-58.0b6'}), kwargs: {}, attempt #1 13:01: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=Devedition-59.0b8-Partial-58.0b6 13:01:26 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/product_add/ 13:01:27 INFO - Server response 13:01:27 INFO - 13:01:27 INFO - linux (linux): /devedition/releases/59.0b8/update/linux-i686/:lang/firefox-58.0b6-59.0b8.partial.mar 13:01:27 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/devedition/releases/59.0b8/update/linux-i686/:lang/firefox-58.0b6-59.0b8.partial.mar', 'product': u'Devedition-59.0b8-Partial-58.0b6', 'os': 'linux'}), kwargs: {}, attempt #1 13:01:27 INFO - POST data: path=%2Fdevedition%2Freleases%2F59.0b8%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-58.0b6-59.0b8.partial.mar&product=Devedition-59.0b8-Partial-58.0b6&os=linux 13:01:27 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 13:01:28 INFO - Server response 13:01:28 INFO - /devedition/releases/59.0b8/update/linux-i686/:lang/firefox-58.0b6-59.0b8.partial.mar 13:01:28 INFO - linux64 (linux64): /devedition/releases/59.0b8/update/linux-x86_64/:lang/firefox-58.0b6-59.0b8.partial.mar 13:01:28 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/devedition/releases/59.0b8/update/linux-x86_64/:lang/firefox-58.0b6-59.0b8.partial.mar', 'product': u'Devedition-59.0b8-Partial-58.0b6', 'os': 'linux64'}), kwargs: {}, attempt #1 13:01:28 INFO - POST data: path=%2Fdevedition%2Freleases%2F59.0b8%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-58.0b6-59.0b8.partial.mar&product=Devedition-59.0b8-Partial-58.0b6&os=linux64 13:01:28 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 13:01:29 INFO - Server response 13:01:29 INFO - /devedition/releases/59.0b8/update/linux-x86_64/:lang/firefox-58.0b6-59.0b8.partial.mar 13:01:29 INFO - macosx64 (osx): /devedition/releases/59.0b8/update/mac/:lang/firefox-58.0b6-59.0b8.partial.mar 13:01:29 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/devedition/releases/59.0b8/update/mac/:lang/firefox-58.0b6-59.0b8.partial.mar', 'product': u'Devedition-59.0b8-Partial-58.0b6', 'os': 'osx'}), kwargs: {}, attempt #1 13:01:29 INFO - POST data: path=%2Fdevedition%2Freleases%2F59.0b8%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-58.0b6-59.0b8.partial.mar&product=Devedition-59.0b8-Partial-58.0b6&os=osx 13:01:29 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 13:01:29 INFO - Server response 13:01:29 INFO - /devedition/releases/59.0b8/update/mac/:lang/firefox-58.0b6-59.0b8.partial.mar 13:01:29 INFO - win32 (win): /devedition/releases/59.0b8/update/win32/:lang/firefox-58.0b6-59.0b8.partial.mar 13:01:29 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/devedition/releases/59.0b8/update/win32/:lang/firefox-58.0b6-59.0b8.partial.mar', 'product': u'Devedition-59.0b8-Partial-58.0b6', 'os': 'win'}), kwargs: {}, attempt #1 13:01:29 INFO - POST data: path=%2Fdevedition%2Freleases%2F59.0b8%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-58.0b6-59.0b8.partial.mar&product=Devedition-59.0b8-Partial-58.0b6&os=win 13:01:29 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 13:01:30 INFO - Server response 13:01:30 INFO - /devedition/releases/59.0b8/update/win32/:lang/firefox-58.0b6-59.0b8.partial.mar 13:01:30 INFO - win64 (win64): /devedition/releases/59.0b8/update/win64/:lang/firefox-58.0b6-59.0b8.partial.mar 13:01:30 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/devedition/releases/59.0b8/update/win64/:lang/firefox-58.0b6-59.0b8.partial.mar', 'product': u'Devedition-59.0b8-Partial-58.0b6', 'os': 'win64'}), kwargs: {}, attempt #1 13:01:30 INFO - POST data: path=%2Fdevedition%2Freleases%2F59.0b8%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-58.0b6-59.0b8.partial.mar&product=Devedition-59.0b8-Partial-58.0b6&os=win64 13:01:30 INFO - Submitting to https://admin-bouncer-releng.stage.mozaws.net/api/location_add/ 13:01:30 INFO - Server response 13:01:30 INFO - /devedition/releases/59.0b8/update/win64/:lang/firefox-58.0b6-59.0b8.partial.mar 13:01:30 INFO - [mozharness: 2018-02-12 21:01:30.959320Z] Finished submit step (success) 13:01:30 INFO - Running post-run listener: copy_logs_to_upload_dir 13:01:30 INFO - Copying logs to upload dir... 13:01:30 INFO - mkdir: /builds/slave/rel-map_de_bncr_sub-0000000000/build/upload/logs 13:01:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=9.820264 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 9 secs) (at 2018-02-12 13:01:30.963435) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2018-02-12 13:01:30.965637) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-map_de_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-326.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-map_de_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.005187 ========= master_lag: 0.04 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2018-02-12 13:01:31.013656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-02-12 13:01:31.013950) ========= rm -f oauth.txt in dir /builds/slave/rel-map_de_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-326.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-map_de_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.002993 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-02-12 13:01:31.060989) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2018-02-12 13:01:31.061265) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2018-02-12 13:01:31.061504) ========= ========= Total master_lag: 0.16 =========