builder: release-maple-firefox_bouncer_aliases slave: bld-linux64-spot-032 starttime: 1512625555.87 results: failure (2) revision: 90b66f7028a4a5aedd179edecb0d3353d19a8ad6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:55.865432) ========= master: http://buildbot-master71.bb.releng.use1.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:55.865848) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:55.866132) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:56.018755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:56.019061) ========= 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-fx_bouncer_aliases-000/. (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-032.build.releng.use1.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-fx_bouncer_aliases-000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False --2017-12-06 21:45:56-- 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% 169K=0.07s 2017-12-06 21:45:56 (169 KB/s) - ‘archiver_client.py’ saved [12179/12179] program finished with exit code 0 elapsedTime=0.517518 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:56.547297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:56.547609) ========= rm -rf scripts properties in dir /builds/slave/rel-map-fx_bouncer_aliases-000/. (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-032.build.releng.use1.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-fx_bouncer_aliases-000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002744 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:56.595116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-12-06 21:45:56.595446) ========= bash -c 'python archiver_client.py mozharness --repo projects/maple --rev 90b66f7028a4a5aedd179edecb0d3353d19a8ad6 --destination scripts --debug' in dir /builds/slave/rel-map-fx_bouncer_aliases-000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/maple --rev 90b66f7028a4a5aedd179edecb0d3353d19a8ad6 --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-032.build.releng.use1.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-fx_bouncer_aliases-000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2017-12-06 21:45:56,638 truncating revision to first 12 chars 2017-12-06 21:45:56,638 Setting DEBUG logging. 2017-12-06 21:45:56,638 attempt 1/10 2017-12-06 21:45:56,638 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/maple/90b66f7028a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-12-06 21:45:57,812 unpacking tar archive at: maple-90b66f7028a4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.477975 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-12-06 21:45:59.082555) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:59.082877) ========= script_repo_revision: 90b66f7028a4a5aedd179edecb0d3353d19a8ad6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:59.083260) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:59.083532) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-12-06 21:45:59.092269) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/release/postrelease_bouncer_aliases.py ...' failed (results: 2, elapsed: 8 mins, 31 secs) (at 2017-12-06 21:45:59.092537) ========= /tools/buildbot/bin/python scripts/scripts/release/postrelease_bouncer_aliases.py -c releases/bouncer_firefox_beta.py in dir /builds/slave/rel-map-fx_bouncer_aliases-000/. (timeout 3600 secs) (maxTime 14400 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/release/postrelease_bouncer_aliases.py', '-c', 'releases/bouncer_firefox_beta.py'] 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-032.build.releng.use1.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-fx_bouncer_aliases-000/buildprops.json PWD=/builds/slave/rel-map-fx_bouncer_aliases-000 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 21:45:59 INFO - MultiFileLogger online at 20171206 21:45:59 in /builds/slave/rel-map-fx_bouncer_aliases-000 21:45:59 INFO - Using buildbot properties: 21:45:59 INFO - { 21:45:59 INFO - "tuxedo_server_url": "https://admin-bouncer-releng.stage.mozaws.net/api/", 21:45:59 INFO - "project": "", 21:45:59 INFO - "product": "firefox", 21:45:59 INFO - "build_number": 11, 21:45:59 INFO - "taskId": "XxINOoE4TmGNOUYK8-ZKWw", 21:45:59 INFO - "repository": "https://hg.mozilla.org/projects/maple", 21:45:59 INFO - "buildername": "release-maple-firefox_bouncer_aliases", 21:45:59 INFO - "basedir": "/builds/slave/rel-map-fx_bouncer_aliases-000", 21:45:59 INFO - "appVersion": "58.0", 21:45:59 INFO - "buildnumber": 0, 21:45:59 INFO - "platform": null, 21:45:59 INFO - "version": "58.0b12", 21:45:59 INFO - "release_promotion": true, 21:45:59 INFO - "script_repo_revision": "90b66f7028a4a5aedd179edecb0d3353d19a8ad6", 21:45:59 INFO - "branch": "maple", 21:45:59 INFO - "master": "http://buildbot-master71.bb.releng.use1.mozilla.com:8001/", 21:45:59 INFO - "revision": "90b66f7028a4a5aedd179edecb0d3353d19a8ad6", 21:45:59 INFO - "slavename": "bld-linux64-spot-032", 21:45:59 INFO - "next_version": "58.0b13", 21:45:59 INFO - "repo_path": "projects/maple" 21:45:59 INFO - } 21:45:59 INFO - Overriding tuxedo_server_url with https://admin-bouncer-releng.stage.mozaws.net/api/ 21:45:59 INFO - Overriding version with 58.0b12 21:45:59 INFO - Run as scripts/scripts/release/postrelease_bouncer_aliases.py -c releases/bouncer_firefox_beta.py 21:45:59 INFO - Dumping config to /builds/slave/rel-map-fx_bouncer_aliases-000/logs/localconfig.json. 21:45:59 INFO - {'append_to_log': False, 21:45:59 INFO - 'base_work_dir': '/builds/slave/rel-map-fx_bouncer_aliases-000', 21:45:59 INFO - 'buildbot_json_path': 'buildprops.json', 21:45:59 INFO - 'config_files': ('releases/bouncer_firefox_beta.py',), 21:45:59 INFO - 'credentials_file': 'oauth.txt', 21:45:59 INFO - 'log_level': 'info', 21:45:59 INFO - 'log_to_console': True, 21:45:59 INFO - 'opt_config_files': (), 21:45:59 INFO - 'partials': {'releases-dir': {'add-locales': True, 21:45:59 INFO - 'check_uptake': True, 21:45:59 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 21:45:59 INFO - 'linux64': {'bouncer-platform': 'linux64', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 21:45:59 INFO - 'macosx64': {'bouncer-platform': 'osx', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 21:45:59 INFO - 'win32': {'bouncer-platform': 'win', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 21:45:59 INFO - 'win64': {'bouncer-platform': 'win64', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 21:45:59 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s', 21:45:59 INFO - 'ssl-only': False}}, 21:45:59 INFO - 'pip_index': True, 21:45:59 INFO - 'products': {'complete-mar': {'add-locales': True, 21:45:59 INFO - 'check_uptake': True, 21:45:59 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 21:45:59 INFO - 'linux64': {'bouncer-platform': 'linux64', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 21:45:59 INFO - 'macosx64': {'bouncer-platform': 'osx', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 21:45:59 INFO - 'win32': {'bouncer-platform': 'win', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 21:45:59 INFO - 'win64': {'bouncer-platform': 'win64', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 21:45:59 INFO - 'product-name': 'Firefox-%(version)s-Complete', 21:45:59 INFO - 'ssl-only': False}, 21:45:59 INFO - 'installer': {'add-locales': True, 21:45:59 INFO - 'alias': 'firefox-beta-latest', 21:45:59 INFO - 'check_uptake': True, 21:45:59 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 21:45:59 INFO - 'linux64': {'bouncer-platform': 'linux64', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 21:45:59 INFO - 'macosx64': {'bouncer-platform': 'osx', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 21:45:59 INFO - 'win32': {'bouncer-platform': 'win', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 21:45:59 INFO - 'win64': {'bouncer-platform': 'win64', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 21:45:59 INFO - 'product-name': 'Firefox-%(version)s', 21:45:59 INFO - 'ssl-only': False}, 21:45:59 INFO - 'installer-ssl': {'add-locales': True, 21:45:59 INFO - 'alias': 'firefox-beta-latest-ssl', 21:45:59 INFO - 'check_uptake': True, 21:45:59 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 21:45:59 INFO - 'linux64': {'bouncer-platform': 'linux64', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 21:45:59 INFO - 'macosx64': {'bouncer-platform': 'osx', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 21:45:59 INFO - 'win32': {'bouncer-platform': 'win', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 21:45:59 INFO - 'win64': {'bouncer-platform': 'win64', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 21:45:59 INFO - 'product-name': 'Firefox-%(version)s-SSL', 21:45:59 INFO - 'ssl-only': True}, 21:45:59 INFO - 'stub-installer': {'add-locales': True, 21:45:59 INFO - 'alias': 'firefox-beta-stub', 21:45:59 INFO - 'check_uptake': True, 21:45:59 INFO - 'paths': {'win32': {'bouncer-platform': 'win', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}, 21:45:59 INFO - 'win64': {'bouncer-platform': 'win64', 21:45:59 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}}, 21:45:59 INFO - 'product-name': 'Firefox-%(version)s-stub', 21:45:59 INFO - 'ssl-only': True}}, 21:45:59 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales', 21:45:59 INFO - 'tuxedo_server_url': u'https://admin-bouncer-releng.stage.mozaws.net/api/', 21:45:59 INFO - 'version': u'58.0b12', 21:45:59 INFO - 'virtualenv_modules': ('redo', 'requests'), 21:45:59 INFO - 'virtualenv_path': 'venv', 21:45:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:45:59 INFO - 'work_dir': 'build'} 21:45:59 INFO - [mozharness: 2017-12-07 05:45:59.235988Z] Running create-virtualenv step. 21:45:59 INFO - Running main action method: create_virtualenv 21:45:59 INFO - Creating virtualenv /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv 21:45:59 INFO - mkdir: /builds/slave/rel-map-fx_bouncer_aliases-000/build 21:45:59 INFO - Running command: ['/tools/buildbot/bin/python', '/builds/slave/rel-map-fx_bouncer_aliases-000/scripts/external_tools/virtualenv/virtualenv.py', '--always-copy', '/builds/slave/rel-map-fx_bouncer_aliases-000/build/venv'] in /builds/slave/rel-map-fx_bouncer_aliases-000/build 21:45:59 INFO - Copy/paste: /tools/buildbot/bin/python /builds/slave/rel-map-fx_bouncer_aliases-000/scripts/external_tools/virtualenv/virtualenv.py --always-copy /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv 21:45:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:46:00 INFO - Using real prefix '/tools/python27' 21:46:00 INFO - Cannot find file lib (bad symlink) 21:46:00 INFO - New python executable in /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/bin/python 21:46:00 INFO - Overwriting /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/distutils/__init__.py with new content 21:46:02 INFO - Installing setuptools, pip, wheel...done. 21:46:02 INFO - Return code: 0 21:46:02 INFO - Installing redo into virtualenv /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv 21:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/bin/pip', 'install', '--timeout', '120', 'redo']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8acb0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f51af8136c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c665e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198ad78>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-map-fx_bouncer_aliases-000/build', 'env': {'MOZ_AUTOMATION': '1', 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 'TMOUT': '86400', 'LOGNAME': 'cltbld', 'USER': 'cltbld', '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', 'DISPLAY': ':2', 'CCACHE_UMASK': '002', 'LANG': 'en_US.UTF-8', 'CCACHE_HASHDIR': '', 'TERM': 'linux', 'SHELL': '/bin/bash', 'SHLVL': '1', 'G_BROKEN_FILENAMES': '1', 'HISTSIZE': '1000', 'HOME': '/home/cltbld', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'TINDERBOX_OUTPUT': '1', 'MAIL': '/var/spool/mail/cltbld', 'LC_ALL': 'C', 'TOOLTOOL_HOME': '/builds', '_': '/tools/buildbot/bin/python', 'HOSTNAME': 'bld-linux64-spot-032.build.releng.use1.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/rel-map-fx_bouncer_aliases-000', 'PROPERTIES_FILE': '/builds/slave/rel-map-fx_bouncer_aliases-000/buildprops.json', 'CCACHE_DIR': '/builds/ccache', 'CCACHE_COMPRESS': '1', 'TOOLTOOL_CACHE': '/builds/tooltool_cache'}}, attempt #1 21:46:02 INFO - Running command: ['/builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/bin/pip', 'install', '--timeout', '120', 'redo'] in /builds/slave/rel-map-fx_bouncer_aliases-000/build 21:46:02 INFO - Copy/paste: /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/bin/pip install --timeout 120 redo 21:46:02 INFO - Using env: {'CCACHE_COMPRESS': '1', 21:46:02 INFO - 'CCACHE_DIR': '/builds/ccache', 21:46:02 INFO - 'CCACHE_HASHDIR': '', 21:46:02 INFO - 'CCACHE_UMASK': '002', 21:46:02 INFO - 'DISPLAY': ':2', 21:46:02 INFO - 'G_BROKEN_FILENAMES': '1', 21:46:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:02 INFO - 'HISTCONTROL': 'ignoredups', 21:46:02 INFO - 'HISTSIZE': '1000', 21:46:02 INFO - 'HOME': '/home/cltbld', 21:46:02 INFO - 'HOSTNAME': 'bld-linux64-spot-032.build.releng.use1.mozilla.com', 21:46:02 INFO - 'LANG': 'en_US.UTF-8', 21:46:02 INFO - 'LC_ALL': 'C', 21:46:02 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 21:46:02 INFO - 'LOGNAME': 'cltbld', 21:46:02 INFO - 'MAIL': '/var/spool/mail/cltbld', 21:46:02 INFO - 'MOZ_AUTOMATION': '1', 21:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:02 INFO - 'MOZ_OBJDIR': 'obj-firefox', 21:46:02 INFO - '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', 21:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-map-fx_bouncer_aliases-000/buildprops.json', 21:46:02 INFO - 'PWD': '/builds/slave/rel-map-fx_bouncer_aliases-000', 21:46:02 INFO - 'SHELL': '/bin/bash', 21:46:02 INFO - 'SHLVL': '1', 21:46:02 INFO - 'TERM': 'linux', 21:46:02 INFO - 'TINDERBOX_OUTPUT': '1', 21:46:02 INFO - 'TMOUT': '86400', 21:46:02 INFO - 'TOOLTOOL_CACHE': '/builds/tooltool_cache', 21:46:02 INFO - 'TOOLTOOL_HOME': '/builds', 21:46:02 INFO - 'USER': 'cltbld', 21:46:02 INFO - '_': '/tools/buildbot/bin/python'} 21:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple 21:46:02 INFO - Collecting redo 21:46:05 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/redo-1.5-py2.py3-none-any.whl 21:46:05 INFO - Installing collected packages: redo 21:46:05 INFO - Successfully installed redo-1.5 21:46:05 INFO - Return code: 0 21:46:05 INFO - Installing requests into virtualenv /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv 21:46:05 INFO - retry: Calling run_command with args: [['/builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/bin/pip', 'install', '--timeout', '120', 'requests']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8acb0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f51af8136c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c665e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198ad78>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-map-fx_bouncer_aliases-000/build', 'env': {'MOZ_AUTOMATION': '1', 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 'TMOUT': '86400', 'LOGNAME': 'cltbld', 'USER': 'cltbld', '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', 'DISPLAY': ':2', 'CCACHE_UMASK': '002', 'LANG': 'en_US.UTF-8', 'CCACHE_HASHDIR': '', 'TERM': 'linux', 'SHELL': '/bin/bash', 'SHLVL': '1', 'G_BROKEN_FILENAMES': '1', 'HISTSIZE': '1000', 'HOME': '/home/cltbld', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'TINDERBOX_OUTPUT': '1', 'MAIL': '/var/spool/mail/cltbld', 'LC_ALL': 'C', 'TOOLTOOL_HOME': '/builds', '_': '/tools/buildbot/bin/python', 'HOSTNAME': 'bld-linux64-spot-032.build.releng.use1.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/rel-map-fx_bouncer_aliases-000', 'PROPERTIES_FILE': '/builds/slave/rel-map-fx_bouncer_aliases-000/buildprops.json', 'CCACHE_DIR': '/builds/ccache', 'CCACHE_COMPRESS': '1', 'TOOLTOOL_CACHE': '/builds/tooltool_cache'}}, attempt #1 21:46:05 INFO - Running command: ['/builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/bin/pip', 'install', '--timeout', '120', 'requests'] in /builds/slave/rel-map-fx_bouncer_aliases-000/build 21:46:05 INFO - Copy/paste: /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/bin/pip install --timeout 120 requests 21:46:05 INFO - Using env: {'CCACHE_COMPRESS': '1', 21:46:05 INFO - 'CCACHE_DIR': '/builds/ccache', 21:46:05 INFO - 'CCACHE_HASHDIR': '', 21:46:05 INFO - 'CCACHE_UMASK': '002', 21:46:05 INFO - 'DISPLAY': ':2', 21:46:05 INFO - 'G_BROKEN_FILENAMES': '1', 21:46:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:05 INFO - 'HISTCONTROL': 'ignoredups', 21:46:05 INFO - 'HISTSIZE': '1000', 21:46:05 INFO - 'HOME': '/home/cltbld', 21:46:05 INFO - 'HOSTNAME': 'bld-linux64-spot-032.build.releng.use1.mozilla.com', 21:46:05 INFO - 'LANG': 'en_US.UTF-8', 21:46:05 INFO - 'LC_ALL': 'C', 21:46:05 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 21:46:05 INFO - 'LOGNAME': 'cltbld', 21:46:05 INFO - 'MAIL': '/var/spool/mail/cltbld', 21:46:05 INFO - 'MOZ_AUTOMATION': '1', 21:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:05 INFO - 'MOZ_OBJDIR': 'obj-firefox', 21:46:05 INFO - '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', 21:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-map-fx_bouncer_aliases-000/buildprops.json', 21:46:05 INFO - 'PWD': '/builds/slave/rel-map-fx_bouncer_aliases-000', 21:46:05 INFO - 'SHELL': '/bin/bash', 21:46:05 INFO - 'SHLVL': '1', 21:46:05 INFO - 'TERM': 'linux', 21:46:05 INFO - 'TINDERBOX_OUTPUT': '1', 21:46:05 INFO - 'TMOUT': '86400', 21:46:05 INFO - 'TOOLTOOL_CACHE': '/builds/tooltool_cache', 21:46:05 INFO - 'TOOLTOOL_HOME': '/builds', 21:46:05 INFO - 'USER': 'cltbld', 21:46:05 INFO - '_': '/tools/buildbot/bin/python'} 21:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple 21:46:05 INFO - Collecting requests 21:46:08 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/requests-2.18.3-py2.py3-none-any.whl (88kB) 21:46:08 INFO - Collecting certifi>=2017.4.17 (from requests) 21:46:10 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/certifi-2017.7.27.1-py2.py3-none-any.whl (349kB) 21:46:11 INFO - Collecting chardet<3.1.0,>=3.0.2 (from requests) 21:46:13 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/chardet-3.0.4-py2.py3-none-any.whl (133kB) 21:46:14 INFO - Collecting urllib3<1.23,>=1.21.1 (from requests) 21:46:16 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/urllib3-1.22-py2.py3-none-any.whl (132kB) 21:46:16 INFO - Collecting idna<2.6,>=2.5 (from requests) 21:46:18 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/idna-2.5-py2.py3-none-any.whl (55kB) 21:46:19 INFO - Installing collected packages: certifi, chardet, urllib3, idna, requests 21:46:19 INFO - Successfully installed certifi-2017.7.27.1 chardet-3.0.4 idna-2.5 requests-2.18.3 urllib3-1.22 21:46:19 INFO - Return code: 0 21:46:19 INFO - Done creating virtualenv /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv. 21:46:19 INFO - Getting output from command: ['/builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/bin/pip', 'freeze'] 21:46:19 INFO - Copy/paste: /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/bin/pip freeze 21:46:20 INFO - Reading from file tmpfile_stdout 21:46:20 INFO - Reading from file tmpfile_stderr 21:46:20 INFO - Current package versions: 21:46:20 INFO - certifi == 2017.7.27.1 21:46:20 INFO - chardet == 3.0.4 21:46:20 INFO - idna == 2.5 21:46:20 INFO - redo == 1.5 21:46:20 INFO - requests == 2.18.3 21:46:20 INFO - urllib3 == 1.22 21:46:20 INFO - [mozharness: 2017-12-07 05:46:20.351660Z] Finished create-virtualenv step (success) 21:46:20 INFO - [mozharness: 2017-12-07 05:46:20.351870Z] Running activate-virtualenv step. 21:46:20 INFO - Running main action method: activate_virtualenv 21:46:20 INFO - [mozharness: 2017-12-07 05:46:20.353034Z] Finished activate-virtualenv step (success) 21:46:20 INFO - [mozharness: 2017-12-07 05:46:20.353228Z] Running update-bouncer-aliases step. 21:46:20 INFO - Running main action method: update_bouncer_aliases 21:46:20 INFO - Updating firefox-beta-latest to point to Firefox-58.0b12 using https://admin-bouncer-releng.stage.mozaws.net/api//create_update_alias /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/urllib3/util/ssl_.py:339: SNIMissingWarning: An HTTPS request has been made, but the SNI (Subject Name Indication) extension to TLS is not available on this platform. This may cause the server to present an incorrect TLS certificate, which can cause validation failures. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings SNIMissingWarning /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/urllib3/util/ssl_.py:137: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/urllib3/connectionpool.py:858: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecureRequestWarning) 21:47:20 INFO - retry: Calling with args: (), kwargs: {}, attempt #2 /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/urllib3/util/ssl_.py:137: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/urllib3/connectionpool.py:858: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecureRequestWarning) 21:48:50 INFO - retry: Calling with args: (), kwargs: {}, attempt #3 /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/urllib3/util/ssl_.py:137: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/urllib3/connectionpool.py:858: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecureRequestWarning) 21:51:06 INFO - retry: Calling with args: (), kwargs: {}, attempt #4 /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/urllib3/util/ssl_.py:137: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/urllib3/connectionpool.py:858: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecureRequestWarning) 21:54:30 INFO - retry: Calling with args: (), kwargs: {}, attempt #5 /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/urllib3/util/ssl_.py:137: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. You can upgrade to a newer version of Python to solve this. For more information, see https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecurePlatformWarning /builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/urllib3/connectionpool.py:858: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings InsecureRequestWarning) 21:54:30 INFO - retry: Giving up on 21:54:30 INFO - [mozharness: 2017-12-07 05:54:30.981784Z] Finished update-bouncer-aliases step (failed) 21:54:30 FATAL - Uncaught exception: Traceback (most recent call last): 21:54:30 FATAL - File "/builds/slave/rel-map-fx_bouncer_aliases-000/scripts/mozharness/base/script.py", line 2059, in run 21:54:30 FATAL - self.run_action(action) 21:54:30 FATAL - File "/builds/slave/rel-map-fx_bouncer_aliases-000/scripts/mozharness/base/script.py", line 1998, in run_action 21:54:30 FATAL - self._possibly_run_method(method_name, error_if_missing=True) 21:54:30 FATAL - File "/builds/slave/rel-map-fx_bouncer_aliases-000/scripts/mozharness/base/script.py", line 1938, in _possibly_run_method 21:54:30 FATAL - return getattr(self, method_name)() 21:54:30 FATAL - File "scripts/scripts/release/postrelease_bouncer_aliases.py", line 102, in update_bouncer_aliases 21:54:30 FATAL - related_product, info["alias"]) 21:54:30 FATAL - File "scripts/scripts/release/postrelease_bouncer_aliases.py", line 87, in _update_bouncer_alias 21:54:30 FATAL - retry(do_update_bouncer_alias) 21:54:30 FATAL - File "/builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/redo/__init__.py", line 152, in retry 21:54:30 FATAL - return action(*args, **kwargs) 21:54:30 FATAL - File "scripts/scripts/release/postrelease_bouncer_aliases.py", line 85, in do_update_bouncer_alias 21:54:30 FATAL - r.raise_for_status() 21:54:30 FATAL - File "/builds/slave/rel-map-fx_bouncer_aliases-000/build/venv/lib/python2.7/site-packages/requests/models.py", line 935, in raise_for_status 21:54:30 FATAL - raise HTTPError(http_error_msg, response=self) 21:54:30 FATAL - HTTPError: 404 Client Error: NOT FOUND for url: https://admin-bouncer-releng.stage.mozaws.net/api//create_update_alias 21:54:30 FATAL - Running post_fatal callback... 21:54:30 FATAL - Exiting -1 21:54:30 INFO - Running post-run listener: copy_logs_to_upload_dir 21:54:30 INFO - Copying logs to upload dir... 21:54:30 INFO - mkdir: /builds/slave/rel-map-fx_bouncer_aliases-000/build/upload/logs program finished with exit code 255 elapsedTime=511.905176 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/release/postrelease_bouncer_aliases.py ...' failed (results: 2, elapsed: 8 mins, 31 secs) (at 2017-12-06 21:54:31.002523) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2017-12-06 21:54:31.004720) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-map-fx_bouncer_aliases-000/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-032.build.releng.use1.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-fx_bouncer_aliases-000/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.004734 ========= master_lag: 0.04 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2017-12-06 21:54:31.052837) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-12-06 21:54:31.053132) ========= rm -f oauth.txt in dir /builds/slave/rel-map-fx_bouncer_aliases-000/. (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-032.build.releng.use1.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-fx_bouncer_aliases-000 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.002400 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-12-06 21:54:31.100125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-12-06 21:54:31.100413) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-12-06 21:54:31.100650) ========= ========= Total master_lag: 0.16 =========