builder: release-jamun-firefox_uptake_monitoring slave: bld-linux64-spot-388 starttime: 1501497999.64 results: failure (2) revision: 42d4c3bc869f494fc5533901298aa45703637392 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:39.637866) ========= master: http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:39.638272) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:39.638551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:39.708237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:39.708501) ========= 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-jamun-fx_uptk_mntr-0000000/. (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-388.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-jamun-fx_uptk_mntr-0000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False --2017-07-31 03:46:39-- 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% 515K=0.02s 2017-07-31 03:46:39 (515 KB/s) - ‘archiver_client.py’ saved [12179/12179] program finished with exit code 0 elapsedTime=0.236073 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:39.957885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:39.958171) ========= rm -rf scripts properties in dir /builds/slave/rel-jamun-fx_uptk_mntr-0000000/. (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-388.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-jamun-fx_uptk_mntr-0000000 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.002871 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:40.005066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:40.005381) ========= bash -c 'python archiver_client.py mozharness --repo projects/jamun --rev 42d4c3bc869f494fc5533901298aa45703637392 --destination scripts --debug' in dir /builds/slave/rel-jamun-fx_uptk_mntr-0000000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/jamun --rev 42d4c3bc869f494fc5533901298aa45703637392 --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-388.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-jamun-fx_uptk_mntr-0000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2017-07-31 03:46:40,056 truncating revision to first 12 chars 2017-07-31 03:46:40,056 Setting DEBUG logging. 2017-07-31 03:46:40,056 attempt 1/10 2017-07-31 03:46:40,056 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/jamun/42d4c3bc869f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-31 03:46:40,518 unpacking tar archive at: jamun-42d4c3bc869f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623245 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:40.637592) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:40.637919) ========= script_repo_revision: 42d4c3bc869f494fc5533901298aa45703637392 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:40.638281) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:40.638546) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 03:46:40.645278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/release/uptake_monitoring.py ...' failed (results: 2, elapsed: 8 mins, 17 secs) (at 2017-07-31 03:46:40.645557) ========= /tools/buildbot/bin/python scripts/scripts/release/uptake_monitoring.py -c releases/bouncer_firefox_beta.py in dir /builds/slave/rel-jamun-fx_uptk_mntr-0000000/. (timeout 3600 secs) (maxTime 14400 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/release/uptake_monitoring.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-388.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-jamun-fx_uptk_mntr-0000000/buildprops.json PWD=/builds/slave/rel-jamun-fx_uptk_mntr-0000000 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 03:46:40 INFO - MultiFileLogger online at 20170731 03:46:40 in /builds/slave/rel-jamun-fx_uptk_mntr-0000000 03:46:40 INFO - Using buildbot properties: 03:46:40 INFO - { 03:46:40 INFO - "tuxedo_server_url": "https://admin-bouncer.stage.mozaws.net/api", 03:46:40 INFO - "project": "", 03:46:40 INFO - "product": "firefox", 03:46:40 INFO - "build_number": 16, 03:46:40 INFO - "taskId": "wIxvM_R7RQyXSlq_YisiyA", 03:46:40 INFO - "repository": "", 03:46:40 INFO - "buildername": "release-jamun-firefox_uptake_monitoring", 03:46:40 INFO - "basedir": "/builds/slave/rel-jamun-fx_uptk_mntr-0000000", 03:46:40 INFO - "partial_versions": "53.0b1build1", 03:46:40 INFO - "buildnumber": 0, 03:46:40 INFO - "slavename": "bld-linux64-spot-388", 03:46:40 INFO - "version": "56.0b1", 03:46:40 INFO - "release_promotion": true, 03:46:40 INFO - "platform": null, 03:46:40 INFO - "branch": "jamun", 03:46:40 INFO - "platforms": "linux, linux64, macosx64, win32, win64", 03:46:40 INFO - "master": "http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/", 03:46:40 INFO - "revision": "42d4c3bc869f494fc5533901298aa45703637392", 03:46:40 INFO - "script_repo_revision": "42d4c3bc869f494fc5533901298aa45703637392", 03:46:40 INFO - "repo_path": "projects/jamun" 03:46:40 INFO - } 03:46:40 INFO - Overriding tuxedo_server_url with https://admin-bouncer.stage.mozaws.net/api 03:46:40 INFO - Overriding version with 56.0b1 03:46:40 INFO - Run as scripts/scripts/release/uptake_monitoring.py -c releases/bouncer_firefox_beta.py 03:46:40 INFO - Dumping config to /builds/slave/rel-jamun-fx_uptk_mntr-0000000/logs/localconfig.json. 03:46:40 INFO - {'append_to_log': False, 03:46:40 INFO - 'base_work_dir': '/builds/slave/rel-jamun-fx_uptk_mntr-0000000', 03:46:40 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:40 INFO - 'config_files': ('releases/bouncer_firefox_beta.py',), 03:46:40 INFO - 'credentials_file': 'oauth.txt', 03:46:40 INFO - 'log_level': 'info', 03:46:40 INFO - 'log_to_console': True, 03:46:40 INFO - 'min_uptake': 10000, 03:46:40 INFO - 'opt_config_files': (), 03:46:40 INFO - 'partial_versions': (u'53.0b1',), 03:46:40 INFO - 'partials': {'releases-dir': {'add-locales': True, 03:46:40 INFO - 'check_uptake': True, 03:46:40 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 03:46:40 INFO - 'linux64': {'bouncer-platform': 'linux64', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 03:46:40 INFO - 'macosx64': {'bouncer-platform': 'osx', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 03:46:40 INFO - 'win32': {'bouncer-platform': 'win', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}, 03:46:40 INFO - 'win64': {'bouncer-platform': 'win64', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}}, 03:46:40 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s', 03:46:40 INFO - 'ssl-only': False}}, 03:46:40 INFO - 'pip_index': True, 03:46:40 INFO - 'platforms': (u'linux', u'linux64', u'macosx64', u'win32', u'win64'), 03:46:40 INFO - 'poll_interval': 60, 03:46:40 INFO - 'poll_timeout': 1200, 03:46:40 INFO - 'products': {'complete-mar': {'add-locales': True, 03:46:40 INFO - 'check_uptake': True, 03:46:40 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'}, 03:46:40 INFO - 'linux64': {'bouncer-platform': 'linux64', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'}, 03:46:40 INFO - 'macosx64': {'bouncer-platform': 'osx', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'}, 03:46:40 INFO - 'win32': {'bouncer-platform': 'win', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'}, 03:46:40 INFO - 'win64': {'bouncer-platform': 'win64', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}}, 03:46:40 INFO - 'product-name': 'Firefox-%(version)s-Complete', 03:46:40 INFO - 'ssl-only': False}, 03:46:40 INFO - 'installer': {'add-locales': True, 03:46:40 INFO - 'alias': 'firefox-beta-latest', 03:46:40 INFO - 'check_uptake': True, 03:46:40 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 03:46:40 INFO - 'linux64': {'bouncer-platform': 'linux64', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 03:46:40 INFO - 'macosx64': {'bouncer-platform': 'osx', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 03:46:40 INFO - 'win32': {'bouncer-platform': 'win', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 03:46:40 INFO - 'win64': {'bouncer-platform': 'win64', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 03:46:40 INFO - 'product-name': 'Firefox-%(version)s', 03:46:40 INFO - 'ssl-only': False}, 03:46:40 INFO - 'installer-ssl': {'add-locales': True, 03:46:40 INFO - 'check_uptake': True, 03:46:40 INFO - 'paths': {'linux': {'bouncer-platform': 'linux', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'}, 03:46:40 INFO - 'linux64': {'bouncer-platform': 'linux64', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'}, 03:46:40 INFO - 'macosx64': {'bouncer-platform': 'osx', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'}, 03:46:40 INFO - 'win32': {'bouncer-platform': 'win', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'}, 03:46:40 INFO - 'win64': {'bouncer-platform': 'win64', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}}, 03:46:40 INFO - 'product-name': 'Firefox-%(version)s-SSL', 03:46:40 INFO - 'ssl-only': True}, 03:46:40 INFO - 'stub-installer': {'add-locales': True, 03:46:40 INFO - 'alias': 'firefox-beta-stub', 03:46:40 INFO - 'check_uptake': True, 03:46:40 INFO - 'paths': {'win32': {'bouncer-platform': 'win', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}, 03:46:40 INFO - 'win64': {'bouncer-platform': 'win64', 03:46:40 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Installer.exe'}}, 03:46:40 INFO - 'product-name': 'Firefox-%(version)s-stub', 03:46:40 INFO - 'ssl-only': True}}, 03:46:40 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales', 03:46:40 INFO - 'tuxedo_server_url': u'https://admin-bouncer.stage.mozaws.net/api', 03:46:40 INFO - 'version': u'56.0b1', 03:46:40 INFO - 'virtualenv_modules': ('redo', 'requests'), 03:46:40 INFO - 'virtualenv_path': 'venv', 03:46:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:40 INFO - 'work_dir': 'build'} 03:46:40 INFO - [mozharness: 2017-07-31 10:46:40.853738Z] Running create-virtualenv step. 03:46:40 INFO - Running main action method: create_virtualenv 03:46:40 INFO - Creating virtualenv /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv 03:46:40 INFO - mkdir: /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build 03:46:40 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv'] in /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build 03:46:40 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv 03:46:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:46:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:40 INFO - New python executable in /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/bin/python2.7 03:46:40 INFO - Also creating executable in /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/bin/python 03:46:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:46:41 INFO - Installing pip...............done. 03:46:41 INFO - Return code: 0 03:46:41 INFO - Getting output from command: ['/builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/bin/pip', '--version'] 03:46:41 INFO - Copy/paste: /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/bin/pip --version 03:46:42 INFO - Reading from file tmpfile_stdout 03:46:42 INFO - Output received: 03:46:42 INFO - pip 1.1 from /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:46:42 INFO - Installing redo into virtualenv /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv 03:46:42 INFO - retry: Calling run_command with args: [['/builds/slave/rel-jamun-fx_uptk_mntr-0000000/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 0x18c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fb420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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 0x18b8108>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1569800>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-jamun-fx_uptk_mntr-0000000/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-388.build.releng.usw2.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/rel-jamun-fx_uptk_mntr-0000000', 'PROPERTIES_FILE': '/builds/slave/rel-jamun-fx_uptk_mntr-0000000/buildprops.json', 'CCACHE_DIR': '/builds/ccache', 'CCACHE_COMPRESS': '1', 'TOOLTOOL_CACHE': '/builds/tooltool_cache'}}, attempt #1 03:46:42 INFO - Running command: ['/builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/bin/pip', 'install', '--timeout', '120', 'redo'] in /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build 03:46:42 INFO - Copy/paste: /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/bin/pip install --timeout 120 redo 03:46:42 INFO - Using env: {'CCACHE_COMPRESS': '1', 03:46:42 INFO - 'CCACHE_DIR': '/builds/ccache', 03:46:42 INFO - 'CCACHE_HASHDIR': '', 03:46:42 INFO - 'CCACHE_UMASK': '002', 03:46:42 INFO - 'DISPLAY': ':2', 03:46:42 INFO - 'G_BROKEN_FILENAMES': '1', 03:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:42 INFO - 'HISTCONTROL': 'ignoredups', 03:46:42 INFO - 'HISTSIZE': '1000', 03:46:42 INFO - 'HOME': '/home/cltbld', 03:46:42 INFO - 'HOSTNAME': 'bld-linux64-spot-388.build.releng.usw2.mozilla.com', 03:46:42 INFO - 'LANG': 'en_US.UTF-8', 03:46:42 INFO - 'LC_ALL': 'C', 03:46:42 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 03:46:42 INFO - 'LOGNAME': 'cltbld', 03:46:42 INFO - 'MAIL': '/var/spool/mail/cltbld', 03:46:42 INFO - 'MOZ_AUTOMATION': '1', 03:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:42 INFO - 'MOZ_OBJDIR': 'obj-firefox', 03:46:42 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', 03:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-jamun-fx_uptk_mntr-0000000/buildprops.json', 03:46:42 INFO - 'PWD': '/builds/slave/rel-jamun-fx_uptk_mntr-0000000', 03:46:42 INFO - 'SHELL': '/bin/bash', 03:46:42 INFO - 'SHLVL': '1', 03:46:42 INFO - 'TERM': 'linux', 03:46:42 INFO - 'TINDERBOX_OUTPUT': '1', 03:46:42 INFO - 'TMOUT': '86400', 03:46:42 INFO - 'TOOLTOOL_CACHE': '/builds/tooltool_cache', 03:46:42 INFO - 'TOOLTOOL_HOME': '/builds', 03:46:42 INFO - 'USER': 'cltbld', 03:46:42 INFO - '_': '/tools/buildbot/bin/python'} 03:46:42 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:46:42 INFO - Downloading/unpacking redo 03:46:42 INFO - Downloading redo-1.5.tar.gz 03:46:42 INFO - Running setup.py egg_info for package redo 03:46:42 INFO - Installing collected packages: redo 03:46:42 INFO - Running setup.py install for redo 03:46:42 INFO - Installing retry script to /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/bin 03:46:42 INFO - Successfully installed redo 03:46:42 INFO - Cleaning up... 03:46:42 INFO - Return code: 0 03:46:42 INFO - Installing requests into virtualenv /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv 03:46:42 INFO - retry: Calling run_command with args: [['/builds/slave/rel-jamun-fx_uptk_mntr-0000000/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 0x18c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fb420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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 0x18b8108>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1569800>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-jamun-fx_uptk_mntr-0000000/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-388.build.releng.usw2.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/rel-jamun-fx_uptk_mntr-0000000', 'PROPERTIES_FILE': '/builds/slave/rel-jamun-fx_uptk_mntr-0000000/buildprops.json', 'CCACHE_DIR': '/builds/ccache', 'CCACHE_COMPRESS': '1', 'TOOLTOOL_CACHE': '/builds/tooltool_cache'}}, attempt #1 03:46:42 INFO - Running command: ['/builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/bin/pip', 'install', '--timeout', '120', 'requests'] in /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build 03:46:42 INFO - Copy/paste: /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/bin/pip install --timeout 120 requests 03:46:42 INFO - Using env: {'CCACHE_COMPRESS': '1', 03:46:42 INFO - 'CCACHE_DIR': '/builds/ccache', 03:46:42 INFO - 'CCACHE_HASHDIR': '', 03:46:42 INFO - 'CCACHE_UMASK': '002', 03:46:42 INFO - 'DISPLAY': ':2', 03:46:42 INFO - 'G_BROKEN_FILENAMES': '1', 03:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:42 INFO - 'HISTCONTROL': 'ignoredups', 03:46:42 INFO - 'HISTSIZE': '1000', 03:46:42 INFO - 'HOME': '/home/cltbld', 03:46:42 INFO - 'HOSTNAME': 'bld-linux64-spot-388.build.releng.usw2.mozilla.com', 03:46:42 INFO - 'LANG': 'en_US.UTF-8', 03:46:42 INFO - 'LC_ALL': 'C', 03:46:42 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 03:46:42 INFO - 'LOGNAME': 'cltbld', 03:46:42 INFO - 'MAIL': '/var/spool/mail/cltbld', 03:46:42 INFO - 'MOZ_AUTOMATION': '1', 03:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:42 INFO - 'MOZ_OBJDIR': 'obj-firefox', 03:46:42 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', 03:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-jamun-fx_uptk_mntr-0000000/buildprops.json', 03:46:42 INFO - 'PWD': '/builds/slave/rel-jamun-fx_uptk_mntr-0000000', 03:46:42 INFO - 'SHELL': '/bin/bash', 03:46:42 INFO - 'SHLVL': '1', 03:46:42 INFO - 'TERM': 'linux', 03:46:42 INFO - 'TINDERBOX_OUTPUT': '1', 03:46:42 INFO - 'TMOUT': '86400', 03:46:42 INFO - 'TOOLTOOL_CACHE': '/builds/tooltool_cache', 03:46:42 INFO - 'TOOLTOOL_HOME': '/builds', 03:46:42 INFO - 'USER': 'cltbld', 03:46:42 INFO - '_': '/tools/buildbot/bin/python'} 03:46:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:46:44 INFO - Downloading/unpacking requests 03:46:44 INFO - Running setup.py egg_info for package requests 03:46:44 INFO - warning: no files found matching 'test_requests.py' 03:46:44 INFO - warning: no files found matching 'requirements.txt' 03:46:44 INFO - Installing collected packages: requests 03:46:44 INFO - Running setup.py install for requests 03:46:44 INFO - warning: no files found matching 'test_requests.py' 03:46:44 INFO - warning: no files found matching 'requirements.txt' 03:46:44 INFO - Successfully installed requests 03:46:44 INFO - Cleaning up... 03:46:44 INFO - Return code: 0 03:46:44 INFO - Done creating virtualenv /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv. 03:46:44 INFO - Getting output from command: ['/builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/bin/pip', 'freeze'] 03:46:44 INFO - Copy/paste: /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/bin/pip freeze 03:46:44 INFO - Reading from file tmpfile_stdout 03:46:44 INFO - Current package versions: 03:46:44 INFO - distribute == 0.6.24 03:46:44 INFO - redo == 1.5 03:46:44 INFO - requests == 2.13.0 03:46:44 INFO - wsgiref == 0.1.2 03:46:44 INFO - [mozharness: 2017-07-31 10:46:44.438545Z] Finished create-virtualenv step (success) 03:46:44 INFO - [mozharness: 2017-07-31 10:46:44.438683Z] Running activate-virtualenv step. 03:46:44 INFO - Running main action method: activate_virtualenv 03:46:44 INFO - [mozharness: 2017-07-31 10:46:44.440005Z] Finished activate-virtualenv step (success) 03:46:44 INFO - [mozharness: 2017-07-31 10:46:44.440161Z] Running monitor-uptake step. 03:46:44 INFO - Running main action method: monitor_uptake 03:46:44 INFO - Starting the loop to determine the uptake monitoring ... 03:46:44 INFO - Requesting https://admin-bouncer.stage.mozaws.net/api/uptake/?product=Firefox-56.0b1&os=win from tuxedo /builds/slave/rel-jamun-fx_uptk_mntr-0000000/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-jamun-fx_uptk_mntr-0000000/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-jamun-fx_uptk_mntr-0000000/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) 03:47:46 INFO - retry: Calling with args: (), kwargs: {}, attempt #2 /builds/slave/rel-jamun-fx_uptk_mntr-0000000/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-jamun-fx_uptk_mntr-0000000/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) 03:49:16 INFO - retry: Calling with args: (), kwargs: {}, attempt #3 /builds/slave/rel-jamun-fx_uptk_mntr-0000000/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-jamun-fx_uptk_mntr-0000000/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) 03:51:32 INFO - retry: Calling with args: (), kwargs: {}, attempt #4 /builds/slave/rel-jamun-fx_uptk_mntr-0000000/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-jamun-fx_uptk_mntr-0000000/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) 03:54:57 INFO - retry: Calling with args: (), kwargs: {}, attempt #5 /builds/slave/rel-jamun-fx_uptk_mntr-0000000/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-jamun-fx_uptk_mntr-0000000/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) 03:54:57 INFO - retry: Giving up on 03:54:57 INFO - [mozharness: 2017-07-31 10:54:57.873455Z] Finished monitor-uptake step (failed) 03:54:57 FATAL - Uncaught exception: Traceback (most recent call last): 03:54:57 FATAL - File "/builds/slave/rel-jamun-fx_uptk_mntr-0000000/scripts/mozharness/base/script.py", line 2068, in run 03:54:57 FATAL - self.run_action(action) 03:54:57 FATAL - File "/builds/slave/rel-jamun-fx_uptk_mntr-0000000/scripts/mozharness/base/script.py", line 2007, in run_action 03:54:57 FATAL - self._possibly_run_method(method_name, error_if_missing=True) 03:54:57 FATAL - File "/builds/slave/rel-jamun-fx_uptk_mntr-0000000/scripts/mozharness/base/script.py", line 1947, in _possibly_run_method 03:54:57 FATAL - return getattr(self, method_name)() 03:54:57 FATAL - File "scripts/scripts/release/uptake_monitoring.py", line 176, in monitor_uptake 03:54:57 FATAL - uptake = self._get_release_uptake(auth) 03:54:57 FATAL - File "scripts/scripts/release/uptake_monitoring.py", line 138, in _get_release_uptake 03:54:57 FATAL - related_product, bouncer_platform)) 03:54:57 FATAL - File "scripts/scripts/release/uptake_monitoring.py", line 113, in _get_product_uptake 03:54:57 FATAL - page = retry(get_tuxedo_page) 03:54:57 FATAL - File "/builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/lib/python2.7/site-packages/redo/__init__.py", line 152, in retry 03:54:57 FATAL - return action(*args, **kwargs) 03:54:57 FATAL - File "scripts/scripts/release/uptake_monitoring.py", line 97, in get_tuxedo_page 03:54:57 FATAL - r.raise_for_status() 03:54:57 FATAL - File "/builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/venv/lib/python2.7/site-packages/requests/models.py", line 909, in raise_for_status 03:54:57 FATAL - raise HTTPError(http_error_msg, response=self) 03:54:57 FATAL - HTTPError: 400 Client Error: BAD REQUEST for url: https://admin-bouncer.stage.mozaws.net/api/uptake/?product=Firefox-56.0b1&os=win 03:54:57 FATAL - Running post_fatal callback... 03:54:57 FATAL - Exiting -1 03:54:57 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:57 INFO - Copying logs to upload dir... 03:54:57 INFO - mkdir: /builds/slave/rel-jamun-fx_uptk_mntr-0000000/build/upload/logs program finished with exit code 255 elapsedTime=497.240760 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/release/uptake_monitoring.py ...' failed (results: 2, elapsed: 8 mins, 17 secs) (at 2017-07-31 03:54:57.898713) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2017-07-31 03:54:57.900509) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-jamun-fx_uptk_mntr-0000000/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-388.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-jamun-fx_uptk_mntr-0000000/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.005021 ========= master_lag: 0.05 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2017-07-31 03:54:57.952869) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:54:57.953183) ========= rm -f oauth.txt in dir /builds/slave/rel-jamun-fx_uptk_mntr-0000000/. (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-388.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-jamun-fx_uptk_mntr-0000000 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.003059 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:54:58.000345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 03:54:58.000642) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 03:54:58.000911) ========= ========= Total master_lag: 0.17 =========