builder: release-jamun-firefox_mark_as_shipped slave: bld-linux64-spot-039 starttime: 1509478148.73 results: failure (2) revision: a3a6860becd3c9ce755f22a168b2afbab2b7d3d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:08.727861) ========= master: http://buildbot-master71.bb.releng.use1.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:08.728345) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:08.728627) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:08.881483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:08.881828) ========= 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_mark_as_shipped-0/. (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-039.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-jamun-fx_mark_as_shipped-0 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False --2017-10-31 12:29:08-- 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% 136M=0s 2017-10-31 12:29:09 (136 MB/s) - ‘archiver_client.py’ saved [12179/12179] program finished with exit code 0 elapsedTime=0.464735 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:09.357719) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:09.358034) ========= rm -rf scripts properties in dir /builds/slave/rel-jamun-fx_mark_as_shipped-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-039.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-jamun-fx_mark_as_shipped-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.003004 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:09.406777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-10-31 12:29:09.407132) ========= bash -c 'python archiver_client.py mozharness --repo projects/jamun --rev a3a6860becd3c9ce755f22a168b2afbab2b7d3d0 --destination scripts --debug' in dir /builds/slave/rel-jamun-fx_mark_as_shipped-0/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/jamun --rev a3a6860becd3c9ce755f22a168b2afbab2b7d3d0 --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-039.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-jamun-fx_mark_as_shipped-0 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2017-10-31 12:29:09,452 truncating revision to first 12 chars 2017-10-31 12:29:09,453 Setting DEBUG logging. 2017-10-31 12:29:09,453 attempt 1/10 2017-10-31 12:29:09,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/jamun/a3a6860becd3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-31 12:29:10,853 unpacking tar archive at: jamun-a3a6860becd3/testing/mozharness/ program finished with exit code 0 elapsedTime=2.433182 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-10-31 12:29:11.850294) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:11.850688) ========= script_repo_revision: a3a6860becd3c9ce755f22a168b2afbab2b7d3d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:11.851080) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:11.851365) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-31 12:29:11.860620) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/release/postrelease_mark_as_shipped.py ...' failed (results: 2, elapsed: 1 mins, 1 secs) (at 2017-10-31 12:29:11.860979) ========= /tools/buildbot/bin/python scripts/scripts/release/postrelease_mark_as_shipped.py -c releases/dev_postrelease_firefox_beta.py in dir /builds/slave/rel-jamun-fx_mark_as_shipped-0/. (timeout 3600 secs) (maxTime 14400 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/release/postrelease_mark_as_shipped.py', '-c', 'releases/dev_postrelease_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-039.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-jamun-fx_mark_as_shipped-0/buildprops.json PWD=/builds/slave/rel-jamun-fx_mark_as_shipped-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 12:29:11 INFO - MultiFileLogger online at 20171031 12:29:11 in /builds/slave/rel-jamun-fx_mark_as_shipped-0 12:29:11 INFO - Using buildbot properties: 12:29:11 INFO - { 12:29:11 INFO - "project": "", 12:29:11 INFO - "product": "firefox", 12:29:11 INFO - "build_number": 27, 12:29:11 INFO - "taskId": "VtRtdQVwRnSzpRBkMvf3eQ", 12:29:11 INFO - "repository": "", 12:29:11 INFO - "buildername": "release-jamun-firefox_mark_as_shipped", 12:29:11 INFO - "basedir": "/builds/slave/rel-jamun-fx_mark_as_shipped-0", 12:29:11 INFO - "buildnumber": 0, 12:29:11 INFO - "platform": null, 12:29:11 INFO - "version": "58.0b1", 12:29:11 INFO - "release_promotion": true, 12:29:11 INFO - "script_repo_revision": "a3a6860becd3c9ce755f22a168b2afbab2b7d3d0", 12:29:11 INFO - "branch": "jamun", 12:29:11 INFO - "master": "http://buildbot-master71.bb.releng.use1.mozilla.com:8001/", 12:29:11 INFO - "revision": "a3a6860becd3c9ce755f22a168b2afbab2b7d3d0", 12:29:11 INFO - "slavename": "bld-linux64-spot-039", 12:29:11 INFO - "next_version": "58.0b2", 12:29:11 INFO - "repo_path": "projects/jamun" 12:29:11 INFO - } 12:29:11 INFO - Overriding product with firefox 12:29:11 INFO - Overriding version with 58.0b1 12:29:11 INFO - Overriding build_number with 27 12:29:11 INFO - Run as scripts/scripts/release/postrelease_mark_as_shipped.py -c releases/dev_postrelease_firefox_beta.py 12:29:11 INFO - Dumping config to /builds/slave/rel-jamun-fx_mark_as_shipped-0/logs/localconfig.json. 12:29:11 INFO - {'append_to_log': False, 12:29:11 INFO - 'base_work_dir': '/builds/slave/rel-jamun-fx_mark_as_shipped-0', 12:29:11 INFO - 'build_number': 27, 12:29:11 INFO - 'buildbot_json_path': 'buildprops.json', 12:29:11 INFO - 'config_files': ('releases/dev_postrelease_firefox_beta.py',), 12:29:11 INFO - 'credentials_file': 'oauth.txt', 12:29:11 INFO - 'ignore_no_changes': True, 12:29:11 INFO - 'log_level': 'info', 12:29:11 INFO - 'log_name': 'bump_date', 12:29:11 INFO - 'log_to_console': True, 12:29:11 INFO - 'name': 'Firefox-58.0b1-build27', 12:29:11 INFO - 'opt_config_files': (), 12:29:11 INFO - 'pip_index': True, 12:29:11 INFO - 'product': u'firefox', 12:29:11 INFO - 'push_dest': 'ssh://hg.mozilla.org/projects/jamun', 12:29:11 INFO - 'repo': {'branch': 'default', 12:29:11 INFO - 'clone_upstream_url': 'https://hg.mozilla.org/mozilla-unified', 12:29:11 INFO - 'dest': 'jamun', 12:29:11 INFO - 'repo': 'https://hg.mozilla.org/projects/jamun', 12:29:11 INFO - 'vcs': 'hg'}, 12:29:11 INFO - 'ship_it_root': 'https://ship-it-dev.allizom.org', 12:29:11 INFO - 'ship_it_username': 'ship_it-stage-ffxbld', 12:29:11 INFO - 'ssh_key': '~/.ssh/ffxbld_rsa', 12:29:11 INFO - 'ssh_user': 'ffxbld', 12:29:11 INFO - 'timeout': 60, 12:29:11 INFO - 'version': u'58.0b1', 12:29:11 INFO - 'version_files': ({'file': 'browser/config/version_display.txt'},), 12:29:11 INFO - 'virtualenv_modules': ('shipitapi',), 12:29:11 INFO - 'virtualenv_path': 'venv', 12:29:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:29:11 INFO - 'work_dir': 'build'} 12:29:11 INFO - [mozharness: 2017-10-31 19:29:11.989046Z] Running create-virtualenv step. 12:29:11 INFO - Running main action method: create_virtualenv 12:29:11 INFO - Creating virtualenv /builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv 12:29:11 INFO - mkdir: /builds/slave/rel-jamun-fx_mark_as_shipped-0/build 12:29:11 INFO - Running command: ['/tools/buildbot/bin/python', '/builds/slave/rel-jamun-fx_mark_as_shipped-0/scripts/external_tools/virtualenv/virtualenv.py', '--always-copy', '/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv'] in /builds/slave/rel-jamun-fx_mark_as_shipped-0/build 12:29:11 INFO - Copy/paste: /tools/buildbot/bin/python /builds/slave/rel-jamun-fx_mark_as_shipped-0/scripts/external_tools/virtualenv/virtualenv.py --always-copy /builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv 12:29:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:29:12 INFO - Using real prefix '/tools/python27' 12:29:12 INFO - Cannot find file lib (bad symlink) 12:29:12 INFO - New python executable in /builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/bin/python 12:29:12 INFO - Overwriting /builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/lib/python2.7/distutils/__init__.py with new content 12:29:13 INFO - Installing setuptools, pip, wheel...done. 12:29:13 INFO - Return code: 0 12:29:13 INFO - Installing shipitapi into virtualenv /builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv 12:29:13 INFO - retry: Calling run_command with args: [['/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/bin/pip', 'install', '--timeout', '120', 'shipitapi']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e8d50>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f27ab288618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24106f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4780>, '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 0x2056540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216dd78>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-jamun-fx_mark_as_shipped-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', '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-039.build.releng.use1.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/rel-jamun-fx_mark_as_shipped-0', 'PROPERTIES_FILE': '/builds/slave/rel-jamun-fx_mark_as_shipped-0/buildprops.json', 'CCACHE_DIR': '/builds/ccache', 'CCACHE_COMPRESS': '1', 'TOOLTOOL_CACHE': '/builds/tooltool_cache'}}, attempt #1 12:29:13 INFO - Running command: ['/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/bin/pip', 'install', '--timeout', '120', 'shipitapi'] in /builds/slave/rel-jamun-fx_mark_as_shipped-0/build 12:29:13 INFO - Copy/paste: /builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/bin/pip install --timeout 120 shipitapi 12:29:13 INFO - Using env: {'CCACHE_COMPRESS': '1', 12:29:13 INFO - 'CCACHE_DIR': '/builds/ccache', 12:29:13 INFO - 'CCACHE_HASHDIR': '', 12:29:13 INFO - 'CCACHE_UMASK': '002', 12:29:13 INFO - 'DISPLAY': ':2', 12:29:13 INFO - 'G_BROKEN_FILENAMES': '1', 12:29:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:13 INFO - 'HISTCONTROL': 'ignoredups', 12:29:13 INFO - 'HISTSIZE': '1000', 12:29:13 INFO - 'HOME': '/home/cltbld', 12:29:13 INFO - 'HOSTNAME': 'bld-linux64-spot-039.build.releng.use1.mozilla.com', 12:29:13 INFO - 'LANG': 'en_US.UTF-8', 12:29:13 INFO - 'LC_ALL': 'C', 12:29:13 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 12:29:13 INFO - 'LOGNAME': 'cltbld', 12:29:13 INFO - 'MAIL': '/var/spool/mail/cltbld', 12:29:13 INFO - 'MOZ_AUTOMATION': '1', 12:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:13 INFO - 'MOZ_OBJDIR': 'obj-firefox', 12:29:13 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', 12:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-jamun-fx_mark_as_shipped-0/buildprops.json', 12:29:13 INFO - 'PWD': '/builds/slave/rel-jamun-fx_mark_as_shipped-0', 12:29:13 INFO - 'SHELL': '/bin/bash', 12:29:13 INFO - 'SHLVL': '1', 12:29:13 INFO - 'TERM': 'linux', 12:29:13 INFO - 'TINDERBOX_OUTPUT': '1', 12:29:13 INFO - 'TMOUT': '86400', 12:29:13 INFO - 'TOOLTOOL_CACHE': '/builds/tooltool_cache', 12:29:13 INFO - 'TOOLTOOL_HOME': '/builds', 12:29:13 INFO - 'USER': 'cltbld', 12:29:13 INFO - '_': '/tools/buildbot/bin/python'} 12:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple 12:29:13 INFO - Collecting shipitapi 12:29:16 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/shipitapi-0.0.3.tar.gz 12:29:16 INFO - Collecting certifi (from shipitapi) 12:29:19 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/certifi-2017.7.27.1-py2.py3-none-any.whl (349kB) 12:29:19 INFO - Collecting requests (from shipitapi) 12:29:21 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/requests-2.18.3-py2.py3-none-any.whl (88kB) 12:29:21 INFO - Collecting redo (from shipitapi) 12:29:24 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/redo-1.5-py2.py3-none-any.whl 12:29:24 INFO - Collecting chardet<3.1.0,>=3.0.2 (from requests->shipitapi) 12:29:26 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/chardet-3.0.4-py2.py3-none-any.whl (133kB) 12:29:26 INFO - Collecting urllib3<1.23,>=1.21.1 (from requests->shipitapi) 12:29:28 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/urllib3-1.22-py2.py3-none-any.whl (132kB) 12:29:29 INFO - Collecting idna<2.6,>=2.5 (from requests->shipitapi) 12:29:31 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/idna-2.5-py2.py3-none-any.whl (55kB) 12:29:31 INFO - Building wheels for collected packages: shipitapi 12:29:31 INFO - Running setup.py bdist_wheel for shipitapi: started 12:29:32 INFO - Running setup.py bdist_wheel for shipitapi: finished with status 'done' 12:29:32 INFO - Stored in directory: /home/cltbld/.cache/pip/wheels/95/3d/c0/265624c7d66748d3b7b976d20e953c297d63621c4255ba8b9e 12:29:32 INFO - Successfully built shipitapi 12:29:32 INFO - Installing collected packages: certifi, chardet, urllib3, idna, requests, redo, shipitapi 12:29:32 INFO - Successfully installed certifi-2017.7.27.1 chardet-3.0.4 idna-2.5 redo-1.5 requests-2.18.3 shipitapi-0.0.3 urllib3-1.22 12:29:32 INFO - Return code: 0 12:29:32 INFO - Done creating virtualenv /builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv. 12:29:32 INFO - Getting output from command: ['/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/bin/pip', 'freeze'] 12:29:32 INFO - Copy/paste: /builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/bin/pip freeze 12:29:32 INFO - Reading from file tmpfile_stdout 12:29:32 INFO - Reading from file tmpfile_stderr 12:29:32 INFO - Current package versions: 12:29:32 INFO - certifi == 2017.7.27.1 12:29:32 INFO - chardet == 3.0.4 12:29:32 INFO - idna == 2.5 12:29:32 INFO - redo == 1.5 12:29:32 INFO - requests == 2.18.3 12:29:32 INFO - shipitapi == 0.0.3 12:29:32 INFO - urllib3 == 1.22 12:29:32 INFO - [mozharness: 2017-10-31 19:29:32.934651Z] Finished create-virtualenv step (success) 12:29:32 INFO - [mozharness: 2017-10-31 19:29:32.934868Z] Running activate-virtualenv step. 12:29:32 INFO - Running main action method: activate_virtualenv 12:29:32 INFO - [mozharness: 2017-10-31 19:29:32.936071Z] Finished activate-virtualenv step (success) 12:29:32 INFO - [mozharness: 2017-10-31 19:29:32.936272Z] Running mark-as-shipped step. 12:29:32 INFO - Running main action method: mark_as_shipped 12:29:32 INFO - Mark the release as shipped with 2017-10-31 19:29:32 timestamp /builds/slave/rel-jamun-fx_mark_as_shipped-0/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-jamun-fx_mark_as_shipped-0/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-jamun-fx_mark_as_shipped-0/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 12:29:37 INFO - retry: Calling with args: (), kwargs: {}, attempt #2 /builds/slave/rel-jamun-fx_mark_as_shipped-0/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 12:29:44 INFO - retry: Calling with args: (), kwargs: {}, attempt #3 /builds/slave/rel-jamun-fx_mark_as_shipped-0/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 12:29:57 INFO - retry: Calling with args: (), kwargs: {}, attempt #4 /builds/slave/rel-jamun-fx_mark_as_shipped-0/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 12:30:12 INFO - retry: Calling with args: (), kwargs: {}, attempt #5 /builds/slave/rel-jamun-fx_mark_as_shipped-0/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 12:30:13 INFO - retry: Giving up on 12:30:13 ERROR - Caught HTTPError: 400 Version 58.0b1 already marked as shipped Traceback (most recent call last): File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/lib/python2.7/site-packages/shipitapi/shipitapi.py", line 79, in request attempts=self.retries) File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/lib/python2.7/site-packages/redo/__init__.py", line 152, in retry return action(*args, **kwargs) File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/lib/python2.7/site-packages/shipitapi/shipitapi.py", line 73, in _req req.raise_for_status() File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/lib/python2.7/site-packages/requests/models.py", line 935, in raise_for_status raise HTTPError(http_error_msg, response=self) HTTPError: 400 Client Error: BAD REQUEST for url: https://ship-it-dev.allizom.org/releases/Firefox-58.0b1-build27 12:30:13 INFO - [mozharness: 2017-10-31 19:30:13.151313Z] Finished mark-as-shipped step (failed) 12:30:13 FATAL - Uncaught exception: Traceback (most recent call last): 12:30:13 FATAL - File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/scripts/mozharness/base/script.py", line 2059, in run 12:30:13 FATAL - self.run_action(action) 12:30:13 FATAL - File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/scripts/mozharness/base/script.py", line 1998, in run_action 12:30:13 FATAL - self._possibly_run_method(method_name, error_if_missing=True) 12:30:13 FATAL - File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/scripts/mozharness/base/script.py", line 1938, in _possibly_run_method 12:30:13 FATAL - return getattr(self, method_name)() 12:30:13 FATAL - File "scripts/scripts/release/postrelease_mark_as_shipped.py", line 106, in mark_as_shipped 12:30:13 FATAL - status='shipped', shippedAt=shipped_at) 12:30:13 FATAL - File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/lib/python2.7/site-packages/shipitapi/shipitapi.py", line 110, in update 12:30:13 FATAL - url_template_vars=url_template_vars).content 12:30:13 FATAL - File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/lib/python2.7/site-packages/shipitapi/shipitapi.py", line 79, in request 12:30:13 FATAL - attempts=self.retries) 12:30:13 FATAL - File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/lib/python2.7/site-packages/redo/__init__.py", line 152, in retry 12:30:13 FATAL - return action(*args, **kwargs) 12:30:13 FATAL - File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/lib/python2.7/site-packages/shipitapi/shipitapi.py", line 73, in _req 12:30:13 FATAL - req.raise_for_status() 12:30:13 FATAL - File "/builds/slave/rel-jamun-fx_mark_as_shipped-0/build/venv/lib/python2.7/site-packages/requests/models.py", line 935, in raise_for_status 12:30:13 FATAL - raise HTTPError(http_error_msg, response=self) 12:30:13 FATAL - HTTPError: 400 Client Error: BAD REQUEST for url: https://ship-it-dev.allizom.org/releases/Firefox-58.0b1-build27 12:30:13 FATAL - Running post_fatal callback... 12:30:13 FATAL - Exiting -1 12:30:13 INFO - Running post-run listener: copy_logs_to_upload_dir 12:30:13 INFO - Copying logs to upload dir... 12:30:13 INFO - mkdir: /builds/slave/rel-jamun-fx_mark_as_shipped-0/build/upload/logs program finished with exit code 255 elapsedTime=61.308948 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/release/postrelease_mark_as_shipped.py ...' failed (results: 2, elapsed: 1 mins, 1 secs) (at 2017-10-31 12:30:13.181488) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2017-10-31 12:30:13.182819) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-jamun-fx_mark_as_shipped-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-039.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-jamun-fx_mark_as_shipped-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.005156 ========= master_lag: 0.04 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2017-10-31 12:30:13.232156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-31 12:30:13.232490) ========= rm -f oauth.txt in dir /builds/slave/rel-jamun-fx_mark_as_shipped-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-039.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-jamun-fx_mark_as_shipped-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.002765 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-31 12:30:13.280742) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-31 12:30:13.281050) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-31 12:30:13.281333) ========= ========= Total master_lag: 0.17 =========