builder: release-mozilla-release-firefox_bouncer_aliases slave: bld-linux64-spot-319 starttime: 1498777272.42 results: success (0) revision: 90f18f9c15f7c71c755e387cfc193974fcf8b29c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:12.424844) ========= master: http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:12.425240) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:12.425512) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:12.620963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:12.621229) ========= rm -rf scripts properties in dir /builds/slave/rel-m-rel-fx_bouncer_aliases-0/. (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-319.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-m-rel-fx_bouncer_aliases-0 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.003885 ========= master_lag: 0.27 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:12.897107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-29 16:01:12.897432) ========= bash -c 'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-release --rev 90f18f9c15f7c71c755e387cfc193974fcf8b29c --destination scripts --debug' in dir /builds/slave/rel-m-rel-fx_bouncer_aliases-0/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-release --rev 90f18f9c15f7c71c755e387cfc193974fcf8b29c --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-319.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-m-rel-fx_bouncer_aliases-0 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2017-06-29 16:01:12,935 truncating revision to first 12 chars 2017-06-29 16:01:12,935 Setting DEBUG logging. 2017-06-29 16:01:12,935 attempt 1/10 2017-06-29 16:01:12,935 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-release/90f18f9c15f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-29 16:01:14,063 unpacking tar archive at: mozilla-release-90f18f9c15f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.546431 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-29 16:01:14.452951) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:14.453244) ========= script_repo_revision: 90f18f9c15f7c71c755e387cfc193974fcf8b29c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:14.453582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:14.453864) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:14.461796) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/release/postrelease_bouncer_aliases.py ...' (results: 0, elapsed: 5 secs) (at 2017-06-29 16:01:14.462059) ========= /tools/buildbot/bin/python scripts/scripts/release/postrelease_bouncer_aliases.py -c releases/bouncer_firefox_release.py in dir /builds/slave/rel-m-rel-fx_bouncer_aliases-0/. (timeout 3600 secs) (maxTime 14400 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/release/postrelease_bouncer_aliases.py', '-c', 'releases/bouncer_firefox_release.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-319.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-m-rel-fx_bouncer_aliases-0/buildprops.json PWD=/builds/slave/rel-m-rel-fx_bouncer_aliases-0 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 16:01:14 INFO - MultiFileLogger online at 20170629 16:01:14 in /builds/slave/rel-m-rel-fx_bouncer_aliases-0 16:01:14 INFO - Using buildbot properties: 16:01:14 INFO - { 16:01:14 INFO - "tuxedo_server_url": "https://bounceradmin.mozilla.com/api", 16:01:14 INFO - "project": "", 16:01:14 INFO - "product": "firefox", 16:01:14 INFO - "build_number": 1, 16:01:14 INFO - "taskId": "nIInV2YwTTKrY5rRXETKdg", 16:01:14 INFO - "repository": "", 16:01:14 INFO - "buildername": "release-mozilla-release-firefox_bouncer_aliases", 16:01:14 INFO - "basedir": "/builds/slave/rel-m-rel-fx_bouncer_aliases-0", 16:01:14 INFO - "buildnumber": 3, 16:01:14 INFO - "platform": null, 16:01:14 INFO - "version": "54.0.1", 16:01:14 INFO - "release_promotion": true, 16:01:14 INFO - "script_repo_revision": "90f18f9c15f7c71c755e387cfc193974fcf8b29c", 16:01:14 INFO - "branch": "mozilla-release", 16:01:14 INFO - "master": "http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/", 16:01:14 INFO - "revision": "90f18f9c15f7c71c755e387cfc193974fcf8b29c", 16:01:14 INFO - "slavename": "bld-linux64-spot-319", 16:01:14 INFO - "repo_path": "releases/mozilla-release" 16:01:14 INFO - } 16:01:14 INFO - Overriding tuxedo_server_url with https://bounceradmin.mozilla.com/api 16:01:14 INFO - Overriding version with 54.0.1 16:01:14 INFO - Run as scripts/scripts/release/postrelease_bouncer_aliases.py -c releases/bouncer_firefox_release.py 16:01:14 INFO - Dumping config to /builds/slave/rel-m-rel-fx_bouncer_aliases-0/logs/localconfig.json. 16:01:14 INFO - {'append_to_log': False, 16:01:14 INFO - 'base_work_dir': '/builds/slave/rel-m-rel-fx_bouncer_aliases-0', 16:01:14 INFO - 'buildbot_json_path': 'buildprops.json', 16:01:14 INFO - 'config_files': ('releases/bouncer_firefox_release.py',), 16:01:14 INFO - 'credentials_file': 'oauth.txt', 16:01:14 INFO - 'log_level': 'info', 16:01:14 INFO - 'log_to_console': True, 16:01:14 INFO - 'opt_config_files': (), 16:01:14 INFO - 'partials': {'candidates-dir': {'add-locales': True, 16:01:14 INFO - 'check_uptake': False, 16:01:14 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 16:01:14 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 16:01:14 INFO - 'linux64': {'bouncer-platform': 'linux64', 16:01:14 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 16:01:14 INFO - 'macosx64': {'bouncer-platform': 'osx', 16:01:14 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 16:01:14 INFO - 'win32': {'bouncer-platform': 'win', 16:01:14 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 16:01:14 INFO - 'win64': {'bouncer-platform': 'win64', 16:01:14 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 16:01:14 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Partial-%(prev_version)sbuild%(prev_build_number)s', 16:01:14 INFO - 'ssl-only': False}, 16:01:14 INFO - 'releases-dir': {'add-locales': True, 16:01:14 INFO - 'check_uptake': True, 16:01:14 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 16:01:14 INFO - 'linux64': {'bouncer-platform': 'linux64', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 16:01:14 INFO - 'macosx64': {'bouncer-platform': 'osx', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 16:01:14 INFO - 'win32': {'bouncer-platform': 'win', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 16:01:14 INFO - 'win64': {'bouncer-platform': 'win64', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 16:01:14 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s', 16:01:14 INFO - 'ssl-only': False}}, 16:01:14 INFO - 'pip_index': True, 16:01:14 INFO - 'products': {'complete-mar': {'add-locales': True, 16:01:14 INFO - 'check_uptake': True, 16:01:14 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 16:01:14 INFO - 'linux64': {'bouncer-platform': 'linux64', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 16:01:14 INFO - 'macosx64': {'bouncer-platform': 'osx', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 16:01:14 INFO - 'win32': {'bouncer-platform': 'win', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 16:01:14 INFO - 'win64': {'bouncer-platform': 'win64', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 16:01:14 INFO - 'product-name': 'Firefox-%(version)s-Complete', 16:01:14 INFO - 'ssl-only': False}, 16:01:14 INFO - 'complete-mar-candidates': {'add-locales': True, 16:01:14 INFO - 'check_uptake': False, 16:01:14 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 16:01:14 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 16:01:14 INFO - 'linux64': {'bouncer-platform': 'linux64', 16:01:14 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 16:01:14 INFO - 'macosx64': {'bouncer-platform': 'osx', 16:01:14 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 16:01:14 INFO - 'win32': {'bouncer-platform': 'win', 16:01:14 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 16:01:14 INFO - 'win64': {'bouncer-platform': 'win64', 16:01:14 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 16:01:14 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete', 16:01:14 INFO - 'ssl-only': False}, 16:01:14 INFO - 'installer': {'add-locales': True, 16:01:14 INFO - 'alias': 'firefox-latest', 16:01:14 INFO - 'check_uptake': True, 16:01:14 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 16:01:14 INFO - 'linux64': {'bouncer-platform': 'linux64', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 16:01:14 INFO - 'macosx64': {'bouncer-platform': 'osx', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 16:01:14 INFO - 'win32': {'bouncer-platform': 'win', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 16:01:14 INFO - 'win64': {'bouncer-platform': 'win64', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 16:01:14 INFO - 'product-name': 'Firefox-%(version)s', 16:01:14 INFO - 'ssl-only': False}, 16:01:14 INFO - 'installer-ssl': {'add-locales': True, 16:01:14 INFO - 'check_uptake': True, 16:01:14 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 16:01:14 INFO - 'linux64': {'bouncer-platform': 'linux64', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 16:01:14 INFO - 'macosx64': {'bouncer-platform': 'osx', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 16:01:14 INFO - 'win32': {'bouncer-platform': 'win', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 16:01:14 INFO - 'win64': {'bouncer-platform': 'win64', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 16:01:14 INFO - 'product-name': 'Firefox-%(version)s-SSL', 16:01:14 INFO - 'ssl-only': True}, 16:01:14 INFO - 'stub-installer': {'add-locales': True, 16:01:14 INFO - 'alias': 'firefox-stub', 16:01:14 INFO - 'check_uptake': True, 16:01:14 INFO - 'paths': {'win32': {'bouncer-platform': 'win', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}, 16:01:14 INFO - 'win64': {'bouncer-platform': 'win64', 16:01:14 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}}, 16:01:14 INFO - 'product-name': 'Firefox-%(version)s-stub', 16:01:14 INFO - 'ssl-only': True}}, 16:01:14 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales', 16:01:14 INFO - 'tuxedo_server_url': u'https://bounceradmin.mozilla.com/api', 16:01:14 INFO - 'version': u'54.0.1', 16:01:14 INFO - 'virtualenv_modules': ('redo', 'requests'), 16:01:14 INFO - 'virtualenv_path': 'venv', 16:01:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:01:14 INFO - 'work_dir': 'build'} 16:01:14 INFO - [mozharness: 2017-06-29 23:01:14.627961Z] Running create-virtualenv step. 16:01:14 INFO - Running main action method: create_virtualenv 16:01:14 INFO - Creating virtualenv /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv 16:01:14 INFO - mkdir: /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build 16:01:14 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv'] in /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build 16:01:14 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv 16:01:14 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:01:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:01:14 INFO - New python executable in /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/bin/python2.7 16:01:14 INFO - Also creating executable in /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/bin/python 16:01:15 INFO - Installing distribute.............................................................................................................................................................................................done. 16:01:15 INFO - Installing pip...............done. 16:01:15 INFO - Return code: 0 16:01:15 INFO - Getting output from command: ['/builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/bin/pip', '--version'] 16:01:15 INFO - Copy/paste: /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/bin/pip --version 16:01:15 INFO - Reading from file tmpfile_stdout 16:01:15 INFO - Output received: 16:01:15 INFO - pip 1.1 from /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:01:15 INFO - Installing redo into virtualenv /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv 16:01:15 INFO - retry: Calling run_command with args: [['/builds/slave/rel-m-rel-fx_bouncer_aliases-0/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 0x254adf0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3a28c3d50>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c2640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ce00>, '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 0x2387c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239ba58>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-m-rel-fx_bouncer_aliases-0/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', 'TINDERBOX_OUTPUT': '1', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'LC_ALL': 'C', 'TOOLTOOL_HOME': '/builds', '_': '/tools/buildbot/bin/python', 'MAIL': '/var/spool/mail/cltbld', 'HOSTNAME': 'bld-linux64-spot-319.build.releng.usw2.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/rel-m-rel-fx_bouncer_aliases-0', 'PROPERTIES_FILE': '/builds/slave/rel-m-rel-fx_bouncer_aliases-0/buildprops.json', 'CCACHE_DIR': '/builds/ccache', 'CCACHE_COMPRESS': '1', 'TOOLTOOL_CACHE': '/builds/tooltool_cache'}}, attempt #1 16:01:15 INFO - Running command: ['/builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/bin/pip', 'install', '--timeout', '120', 'redo'] in /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build 16:01:15 INFO - Copy/paste: /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/bin/pip install --timeout 120 redo 16:01:15 INFO - Using env: {'CCACHE_COMPRESS': '1', 16:01:15 INFO - 'CCACHE_DIR': '/builds/ccache', 16:01:15 INFO - 'CCACHE_HASHDIR': '', 16:01:15 INFO - 'CCACHE_UMASK': '002', 16:01:15 INFO - 'DISPLAY': ':2', 16:01:15 INFO - 'G_BROKEN_FILENAMES': '1', 16:01:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:15 INFO - 'HISTCONTROL': 'ignoredups', 16:01:15 INFO - 'HISTSIZE': '1000', 16:01:15 INFO - 'HOME': '/home/cltbld', 16:01:15 INFO - 'HOSTNAME': 'bld-linux64-spot-319.build.releng.usw2.mozilla.com', 16:01:15 INFO - 'LANG': 'en_US.UTF-8', 16:01:15 INFO - 'LC_ALL': 'C', 16:01:15 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 16:01:15 INFO - 'LOGNAME': 'cltbld', 16:01:15 INFO - 'MAIL': '/var/spool/mail/cltbld', 16:01:15 INFO - 'MOZ_AUTOMATION': '1', 16:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:15 INFO - 'MOZ_OBJDIR': 'obj-firefox', 16:01:15 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', 16:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-m-rel-fx_bouncer_aliases-0/buildprops.json', 16:01:15 INFO - 'PWD': '/builds/slave/rel-m-rel-fx_bouncer_aliases-0', 16:01:15 INFO - 'SHELL': '/bin/bash', 16:01:15 INFO - 'SHLVL': '1', 16:01:15 INFO - 'TERM': 'linux', 16:01:15 INFO - 'TINDERBOX_OUTPUT': '1', 16:01:15 INFO - 'TMOUT': '86400', 16:01:15 INFO - 'TOOLTOOL_CACHE': '/builds/tooltool_cache', 16:01:15 INFO - 'TOOLTOOL_HOME': '/builds', 16:01:15 INFO - 'USER': 'cltbld', 16:01:15 INFO - '_': '/tools/buildbot/bin/python'} 16:01:16 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:01:16 INFO - Downloading/unpacking redo 16:01:16 INFO - Downloading redo-1.5.tar.gz 16:01:16 INFO - Running setup.py egg_info for package redo 16:01:16 INFO - Installing collected packages: redo 16:01:16 INFO - Running setup.py install for redo 16:01:16 INFO - Installing retry script to /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/bin 16:01:16 INFO - Successfully installed redo 16:01:16 INFO - Cleaning up... 16:01:16 INFO - Return code: 0 16:01:16 INFO - Installing requests into virtualenv /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv 16:01:16 INFO - retry: Calling run_command with args: [['/builds/slave/rel-m-rel-fx_bouncer_aliases-0/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 0x254adf0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3a28c3d50>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c2640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ce00>, '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 0x2387c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239ba58>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-m-rel-fx_bouncer_aliases-0/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', 'TINDERBOX_OUTPUT': '1', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'LC_ALL': 'C', 'TOOLTOOL_HOME': '/builds', '_': '/tools/buildbot/bin/python', 'MAIL': '/var/spool/mail/cltbld', 'HOSTNAME': 'bld-linux64-spot-319.build.releng.usw2.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/rel-m-rel-fx_bouncer_aliases-0', 'PROPERTIES_FILE': '/builds/slave/rel-m-rel-fx_bouncer_aliases-0/buildprops.json', 'CCACHE_DIR': '/builds/ccache', 'CCACHE_COMPRESS': '1', 'TOOLTOOL_CACHE': '/builds/tooltool_cache'}}, attempt #1 16:01:16 INFO - Running command: ['/builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/bin/pip', 'install', '--timeout', '120', 'requests'] in /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build 16:01:16 INFO - Copy/paste: /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/bin/pip install --timeout 120 requests 16:01:16 INFO - Using env: {'CCACHE_COMPRESS': '1', 16:01:16 INFO - 'CCACHE_DIR': '/builds/ccache', 16:01:16 INFO - 'CCACHE_HASHDIR': '', 16:01:16 INFO - 'CCACHE_UMASK': '002', 16:01:16 INFO - 'DISPLAY': ':2', 16:01:16 INFO - 'G_BROKEN_FILENAMES': '1', 16:01:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:16 INFO - 'HISTCONTROL': 'ignoredups', 16:01:16 INFO - 'HISTSIZE': '1000', 16:01:16 INFO - 'HOME': '/home/cltbld', 16:01:16 INFO - 'HOSTNAME': 'bld-linux64-spot-319.build.releng.usw2.mozilla.com', 16:01:16 INFO - 'LANG': 'en_US.UTF-8', 16:01:16 INFO - 'LC_ALL': 'C', 16:01:16 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 16:01:16 INFO - 'LOGNAME': 'cltbld', 16:01:16 INFO - 'MAIL': '/var/spool/mail/cltbld', 16:01:16 INFO - 'MOZ_AUTOMATION': '1', 16:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:16 INFO - 'MOZ_OBJDIR': 'obj-firefox', 16:01:16 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', 16:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-m-rel-fx_bouncer_aliases-0/buildprops.json', 16:01:16 INFO - 'PWD': '/builds/slave/rel-m-rel-fx_bouncer_aliases-0', 16:01:16 INFO - 'SHELL': '/bin/bash', 16:01:16 INFO - 'SHLVL': '1', 16:01:16 INFO - 'TERM': 'linux', 16:01:16 INFO - 'TINDERBOX_OUTPUT': '1', 16:01:16 INFO - 'TMOUT': '86400', 16:01:16 INFO - 'TOOLTOOL_CACHE': '/builds/tooltool_cache', 16:01:16 INFO - 'TOOLTOOL_HOME': '/builds', 16:01:16 INFO - 'USER': 'cltbld', 16:01:16 INFO - '_': '/tools/buildbot/bin/python'} 16:01:18 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:01:18 INFO - Downloading/unpacking requests 16:01:18 INFO - Running setup.py egg_info for package requests 16:01:18 INFO - warning: no files found matching 'test_requests.py' 16:01:18 INFO - warning: no files found matching 'requirements.txt' 16:01:18 INFO - Installing collected packages: requests 16:01:18 INFO - Running setup.py install for requests 16:01:18 INFO - warning: no files found matching 'test_requests.py' 16:01:18 INFO - warning: no files found matching 'requirements.txt' 16:01:18 INFO - Successfully installed requests 16:01:18 INFO - Cleaning up... 16:01:18 INFO - Return code: 0 16:01:18 INFO - Done creating virtualenv /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv. 16:01:18 INFO - Getting output from command: ['/builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/bin/pip', 'freeze'] 16:01:18 INFO - Copy/paste: /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/bin/pip freeze 16:01:18 INFO - Reading from file tmpfile_stdout 16:01:18 INFO - Current package versions: 16:01:18 INFO - distribute == 0.6.24 16:01:18 INFO - redo == 1.5 16:01:18 INFO - requests == 2.13.0 16:01:18 INFO - wsgiref == 0.1.2 16:01:18 INFO - [mozharness: 2017-06-29 23:01:18.363080Z] Finished create-virtualenv step (success) 16:01:18 INFO - [mozharness: 2017-06-29 23:01:18.363218Z] Running activate-virtualenv step. 16:01:18 INFO - Running main action method: activate_virtualenv 16:01:18 INFO - [mozharness: 2017-06-29 23:01:18.364511Z] Finished activate-virtualenv step (success) 16:01:18 INFO - [mozharness: 2017-06-29 23:01:18.364664Z] Running update-bouncer-aliases step. 16:01:18 INFO - Running main action method: update_bouncer_aliases 16:01:18 INFO - Updating firefox-latest to point to Firefox-54.0.1 using https://bounceradmin.mozilla.com/api/create_update_alias /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/lib/python2.7/site-packages/requests/packages/urllib3/util/ssl_.py:334: 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-m-rel-fx_bouncer_aliases-0/build/venv/lib/python2.7/site-packages/requests/packages/urllib3/util/ssl_.py:132: 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-m-rel-fx_bouncer_aliases-0/build/venv/lib/python2.7/site-packages/requests/packages/urllib3/connectionpool.py:852: 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) 16:01:19 INFO - Updating firefox-stub to point to Firefox-54.0.1-stub using https://bounceradmin.mozilla.com/api/create_update_alias /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/venv/lib/python2.7/site-packages/requests/packages/urllib3/util/ssl_.py:132: 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-m-rel-fx_bouncer_aliases-0/build/venv/lib/python2.7/site-packages/requests/packages/urllib3/connectionpool.py:852: 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) 16:01:19 INFO - [mozharness: 2017-06-29 23:01:19.736607Z] Finished update-bouncer-aliases step (success) 16:01:19 INFO - Running post-run listener: copy_logs_to_upload_dir 16:01:19 INFO - Copying logs to upload dir... 16:01:19 INFO - mkdir: /builds/slave/rel-m-rel-fx_bouncer_aliases-0/build/upload/logs 16:01:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=5.294052 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/release/postrelease_bouncer_aliases.py ...' (results: 0, elapsed: 5 secs) (at 2017-06-29 16:01:20.001152) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:20.003537) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-m-rel-fx_bouncer_aliases-0/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-319.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-m-rel-fx_bouncer_aliases-0/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.005390 ========= master_lag: 0.13 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2017-06-29 16:01:20.138090) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-06-29 16:01:20.166901) ========= rm -f oauth.txt in dir /builds/slave/rel-m-rel-fx_bouncer_aliases-0/. (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-319.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-m-rel-fx_bouncer_aliases-0 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.003203 ========= master_lag: 1.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-06-29 16:01:21.274661) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-29 16:01:21.274985) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-29 16:01:21.276597) ========= ========= Total master_lag: 1.76 =========