builder: ash-win64-debug slave: b-2008-spot-029 starttime: 1487600661.32 results: failure (2) buildid: 20170220062259 builduid: ba9a709595bd431b97418cb594d0bf2d revision: 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:21.327696) ========= master: http://buildbot-master94.bb.releng.use1.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:21.328130) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:21.328404) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:21.509803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-20 06:24:21.510159) ========= '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 c:\builds\moz2_slave\ash-w64-d-00000000000000000000\. (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: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv BUILDBOT_PATH=C:\mozilla-build\buildbotve CHOCOLATEYINSTALL=C:\ProgramData\chocolatey COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=B-2008-SPOT-029 COMSPEC=C:\Windows\system32\cmd.exe CVS_RSH=ssh DXSDK_DIR=C:\Program Files (x86)\Microsoft DirectX SDK (June 2010)\ EDITOR=emacs.exe FP_NO_HOST_CHECK=NO GIT_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/git-shared HG_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/hg-shared HOME=c:/Users/cltbld HOMEDRIVE=C: HOMEPATH=\ HOSTTYPE=i686 IDLEIZER_HALT_ON_IDLE=true INPUTRC=C:/mozilla-build/msys/etc/inputrc LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOG="c:\runner\buildbot-startup.log" LOGNAME=cltbld LOGONSERVER=\\B-2008-SPOT-029 MACHTYPE=i686-pc-msys MAKE_MODE=unix MOZBUILDDIR=C:\mozilla-build MOZILLABUILD=C:\mozilla-build MOZ_TOOLS=C:\mozilla-build\moztools-x64 MSYSTEM=MINGW32 NUMBER_OF_PROCESSORS=16 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\buildbotve\Scripts;c:\ProgramData\chocolatey\bin;.;c:\opt\runner;c:\mozilla-build\buildbotve;c:\mozilla-build\python27;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;.;C:\mozilla-build\msys\local\bin;c:\mozilla-build\moztools-x64\bin;c:\mozilla-build\vim\vim72 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 62 Stepping 4, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=3e04 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PS1=\[\033]0;$MSYSTEM:\w\007 \033[32m\]\u@\h \[\033[33m\w\033[0m\] $ PSMODULEPATH=C:\Windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files (x86)\AWS Tools\PowerShell\ PUBLIC=C:\Users\Public PWD=c:/Users/cltbld RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg SHELL=C:/mozilla-build/msys/bin/sh SHLVL=1 SSH_AGENT_PID=2268 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048 SYSTEMDRIVE=C: SYSTEMROOT=C:\Windows TEMP=C:/Users/cltbld/AppData/Local/Temp TERM=cygwin TMP=C:/Users/cltbld/AppData/Local/Temp USERDOMAIN=B-2008-SPOT-029 USERNAME=cltbld USERPROFILE=C:\Users\cltbld VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\ VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\ VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\ WINDIR=C:\Windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log WIX_351728_PATH=c:/mozilla-build/wix-351728 _=C:\mozilla-build\buildbotve\Scripts\python using PTY: False --2017-02-20 06:24:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (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% 32.9K=0.4s 2017-02-20 06:24:20 (32.9 KB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.856000 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-20 06:24:23.377716) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:23.378696) ========= 'rm' '-rf' 'scripts' 'properties' in dir c:\builds\moz2_slave\ash-w64-d-00000000000000000000\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv BUILDBOT_PATH=C:\mozilla-build\buildbotve CHOCOLATEYINSTALL=C:\ProgramData\chocolatey COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=B-2008-SPOT-029 COMSPEC=C:\Windows\system32\cmd.exe CVS_RSH=ssh DXSDK_DIR=C:\Program Files (x86)\Microsoft DirectX SDK (June 2010)\ EDITOR=emacs.exe FP_NO_HOST_CHECK=NO GIT_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/git-shared HG_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/hg-shared HOME=c:/Users/cltbld HOMEDRIVE=C: HOMEPATH=\ HOSTTYPE=i686 IDLEIZER_HALT_ON_IDLE=true INPUTRC=C:/mozilla-build/msys/etc/inputrc LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOG="c:\runner\buildbot-startup.log" LOGNAME=cltbld LOGONSERVER=\\B-2008-SPOT-029 MACHTYPE=i686-pc-msys MAKE_MODE=unix MOZBUILDDIR=C:\mozilla-build MOZILLABUILD=C:\mozilla-build MOZ_TOOLS=C:\mozilla-build\moztools-x64 MSYSTEM=MINGW32 NUMBER_OF_PROCESSORS=16 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\buildbotve\Scripts;c:\ProgramData\chocolatey\bin;.;c:\opt\runner;c:\mozilla-build\buildbotve;c:\mozilla-build\python27;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;.;C:\mozilla-build\msys\local\bin;c:\mozilla-build\moztools-x64\bin;c:\mozilla-build\vim\vim72 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 62 Stepping 4, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=3e04 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PS1=\[\033]0;$MSYSTEM:\w\007 \033[32m\]\u@\h \[\033[33m\w\033[0m\] $ PSMODULEPATH=C:\Windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files (x86)\AWS Tools\PowerShell\ PUBLIC=C:\Users\Public PWD=c:/Users/cltbld RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg SHELL=C:/mozilla-build/msys/bin/sh SHLVL=1 SSH_AGENT_PID=2268 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048 SYSTEMDRIVE=C: SYSTEMROOT=C:\Windows TEMP=C:/Users/cltbld/AppData/Local/Temp TERM=cygwin TMP=C:/Users/cltbld/AppData/Local/Temp USERDOMAIN=B-2008-SPOT-029 USERNAME=cltbld USERPROFILE=C:\Users\cltbld VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\ VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\ VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\ WINDIR=C:\Windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log WIX_351728_PATH=c:/mozilla-build/wix-351728 _=C:\mozilla-build\buildbotve\Scripts\python using PTY: False program finished with exit code 0 elapsedTime=0.107000 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:23.493719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-20 06:24:23.494688) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo projects/ash --rev 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd --destination scripts --debug' in dir c:\builds\moz2_slave\ash-w64-d-00000000000000000000\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/ash --rev 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv BUILDBOT_PATH=C:\mozilla-build\buildbotve CHOCOLATEYINSTALL=C:\ProgramData\chocolatey COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=B-2008-SPOT-029 COMSPEC=C:\Windows\system32\cmd.exe CVS_RSH=ssh DXSDK_DIR=C:\Program Files (x86)\Microsoft DirectX SDK (June 2010)\ EDITOR=emacs.exe FP_NO_HOST_CHECK=NO GIT_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/git-shared HG_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/hg-shared HOME=c:/Users/cltbld HOMEDRIVE=C: HOMEPATH=\ HOSTTYPE=i686 IDLEIZER_HALT_ON_IDLE=true INPUTRC=C:/mozilla-build/msys/etc/inputrc LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOG="c:\runner\buildbot-startup.log" LOGNAME=cltbld LOGONSERVER=\\B-2008-SPOT-029 MACHTYPE=i686-pc-msys MAKE_MODE=unix MOZBUILDDIR=C:\mozilla-build MOZILLABUILD=C:\mozilla-build MOZ_TOOLS=C:\mozilla-build\moztools-x64 MSYSTEM=MINGW32 NUMBER_OF_PROCESSORS=16 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\buildbotve\Scripts;c:\ProgramData\chocolatey\bin;.;c:\opt\runner;c:\mozilla-build\buildbotve;c:\mozilla-build\python27;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;.;C:\mozilla-build\msys\local\bin;c:\mozilla-build\moztools-x64\bin;c:\mozilla-build\vim\vim72 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 62 Stepping 4, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=3e04 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PS1=\[\033]0;$MSYSTEM:\w\007 \033[32m\]\u@\h \[\033[33m\w\033[0m\] $ PSMODULEPATH=C:\Windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files (x86)\AWS Tools\PowerShell\ PUBLIC=C:\Users\Public PWD=c:/Users/cltbld RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg SHELL=C:/mozilla-build/msys/bin/sh SHLVL=1 SSH_AGENT_PID=2268 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048 SYSTEMDRIVE=C: SYSTEMROOT=C:\Windows TEMP=C:/Users/cltbld/AppData/Local/Temp TERM=cygwin TMP=C:/Users/cltbld/AppData/Local/Temp USERDOMAIN=B-2008-SPOT-029 USERNAME=cltbld USERPROFILE=C:\Users\cltbld VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\ VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\ VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\ WINDIR=C:\Windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log WIX_351728_PATH=c:/mozilla-build/wix-351728 _=C:\mozilla-build\buildbotve\Scripts\python using PTY: False 2017-02-20 06:24:20,861 truncating revision to first 12 chars 2017-02-20 06:24:20,861 Setting DEBUG logging. 2017-02-20 06:24:20,861 attempt 1/10 2017-02-20 06:24:20,861 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/ash/2b927c6e3817?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-20 06:24:22,141 unpacking tar archive at: ash-2b927c6e3817/testing/mozharness/ 2017-02-20 06:24:22,296 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=2.412000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-20 06:24:25.921746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:25.922708) ========= script_repo_revision: 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:25.923185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:25.923452) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:25.931346) ========= ========= Started remove old nonce (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:25.931599) ========= 'rm' '-f' 'nonce' in dir c:\builds\moz2_slave\ash-w64-d-00000000000000000000\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'nonce'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv BUILDBOT_PATH=C:\mozilla-build\buildbotve CHOCOLATEYINSTALL=C:\ProgramData\chocolatey COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=B-2008-SPOT-029 COMSPEC=C:\Windows\system32\cmd.exe CVS_RSH=ssh DXSDK_DIR=C:\Program Files (x86)\Microsoft DirectX SDK (June 2010)\ EDITOR=emacs.exe FP_NO_HOST_CHECK=NO GIT_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/git-shared HG_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/hg-shared HOME=c:/Users/cltbld HOMEDRIVE=C: HOMEPATH=\ HOSTTYPE=i686 IDLEIZER_HALT_ON_IDLE=true INPUTRC=C:/mozilla-build/msys/etc/inputrc LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOG="c:\runner\buildbot-startup.log" LOGNAME=cltbld LOGONSERVER=\\B-2008-SPOT-029 MACHTYPE=i686-pc-msys MAKE_MODE=unix MOZBUILDDIR=C:\mozilla-build MOZILLABUILD=C:\mozilla-build MOZ_TOOLS=C:\mozilla-build\moztools-x64 MSYSTEM=MINGW32 NUMBER_OF_PROCESSORS=16 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\buildbotve\Scripts;c:\ProgramData\chocolatey\bin;.;c:\opt\runner;c:\mozilla-build\buildbotve;c:\mozilla-build\python27;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;.;C:\mozilla-build\msys\local\bin;c:\mozilla-build\moztools-x64\bin;c:\mozilla-build\vim\vim72 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 62 Stepping 4, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=3e04 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PS1=\[\033]0;$MSYSTEM:\w\007 \033[32m\]\u@\h \[\033[33m\w\033[0m\] $ PSMODULEPATH=C:\Windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files (x86)\AWS Tools\PowerShell\ PUBLIC=C:\Users\Public PWD=c:/Users/cltbld RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg SHELL=C:/mozilla-build/msys/bin/sh SHLVL=1 SSH_AGENT_PID=2268 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048 SYSTEMDRIVE=C: SYSTEMROOT=C:\Windows TEMP=C:/Users/cltbld/AppData/Local/Temp TERM=cygwin TMP=C:/Users/cltbld/AppData/Local/Temp USERDOMAIN=B-2008-SPOT-029 USERNAME=cltbld USERPROFILE=C:\Users\cltbld VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\ VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\ VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\ WINDIR=C:\Windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log WIX_351728_PATH=c:/mozilla-build/wix-351728 _=C:\mozilla-build\buildbotve\Scripts\python using PTY: False program finished with exit code 0 elapsedTime=0.107000 ========= master_lag: 0.01 ========= ========= Finished remove old nonce (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:26.045750) ========= ========= Started downloading to token (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:26.046618) ========= Slave: b-2008-spot-029 IP: 10.134.55.24 Duration: 25200 URI: https://mac-v2-signing2.srv.releng.scl3.mozilla.com:9110/token ========= Finished downloading to token (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:26.537464) ========= ========= Started set props: toolsdir (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:26.537879) ========= 'bash' '-c' 'pwd' in dir c:\builds\moz2_slave\ash-w64-d-00000000000000000000\scripts (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv BUILDBOT_PATH=C:\mozilla-build\buildbotve CHOCOLATEYINSTALL=C:\ProgramData\chocolatey COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=B-2008-SPOT-029 COMSPEC=C:\Windows\system32\cmd.exe CVS_RSH=ssh DXSDK_DIR=C:\Program Files (x86)\Microsoft DirectX SDK (June 2010)\ EDITOR=emacs.exe FP_NO_HOST_CHECK=NO GIT_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/git-shared HG_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/hg-shared HOME=c:/Users/cltbld HOMEDRIVE=C: HOMEPATH=\ HOSTTYPE=i686 IDLEIZER_HALT_ON_IDLE=true INPUTRC=C:/mozilla-build/msys/etc/inputrc LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOG="c:\runner\buildbot-startup.log" LOGNAME=cltbld LOGONSERVER=\\B-2008-SPOT-029 MACHTYPE=i686-pc-msys MAKE_MODE=unix MOZBUILDDIR=C:\mozilla-build MOZILLABUILD=C:\mozilla-build MOZ_TOOLS=C:\mozilla-build\moztools-x64 MSYSTEM=MINGW32 NUMBER_OF_PROCESSORS=16 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\buildbotve\Scripts;c:\ProgramData\chocolatey\bin;.;c:\opt\runner;c:\mozilla-build\buildbotve;c:\mozilla-build\python27;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;.;C:\mozilla-build\msys\local\bin;c:\mozilla-build\moztools-x64\bin;c:\mozilla-build\vim\vim72 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 62 Stepping 4, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=3e04 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PS1=\[\033]0;$MSYSTEM:\w\007 \033[32m\]\u@\h \[\033[33m\w\033[0m\] $ PSMODULEPATH=C:\Windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files (x86)\AWS Tools\PowerShell\ PUBLIC=C:\Users\Public PWD=c:/Users/cltbld RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg SHELL=C:/mozilla-build/msys/bin/sh SHLVL=1 SSH_AGENT_PID=2268 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048 SYSTEMDRIVE=C: SYSTEMROOT=C:\Windows TEMP=C:/Users/cltbld/AppData/Local/Temp TERM=cygwin TMP=C:/Users/cltbld/AppData/Local/Temp USERDOMAIN=B-2008-SPOT-029 USERNAME=cltbld USERPROFILE=C:\Users\cltbld VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\ VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\ VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\ WINDIR=C:\Windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log WIX_351728_PATH=c:/mozilla-build/wix-351728 _=C:\mozilla-build\buildbotve\Scripts\python using PTY: False /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts program finished with exit code 0 elapsedTime=0.107000 toolsdir: '/c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts' ========= master_lag: 0.01 ========= ========= Finished set props: toolsdir (results: 0, elapsed: 0 secs) (at 2017-02-20 06:24:26.653837) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 41 mins, 49 secs) (at 2017-02-20 06:24:26.654721) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/fx_desktop_build.py' '--config' 'builds/releng_base_windows_64_builds.py' '--custom-build-variant-cfg' 'debug' '--config' 'balrog/production.py' '--branch' 'ash' '--build-pool' 'production' in dir c:\builds\moz2_slave\ash-w64-d-00000000000000000000\. (timeout 10800 secs) (maxTime 27000 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/fx_desktop_build.py', '--config', 'builds/releng_base_windows_64_builds.py', '--custom-build-variant-cfg', 'debug', '--config', 'balrog/production.py', '--branch', 'ash', '--build-pool', 'production'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv BINSCOPE=C:\Program Files (x86)\Microsoft\SDL BinScope\BinScope.exe BUILDBOT_PATH=C:\mozilla-build\buildbotve CHOCOLATEYINSTALL=C:\ProgramData\chocolatey COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=B-2008-SPOT-029 COMSPEC=C:\Windows\system32\cmd.exe CVS_RSH=ssh DXSDK_DIR=C:\Program Files (x86)\Microsoft DirectX SDK (June 2010)\ EDITOR=emacs.exe FP_NO_HOST_CHECK=NO GIT_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/git-shared HG_SHARE_BASE_DIR=c:/builds/hg-shared HOME=c:/Users/cltbld HOMEDRIVE=C: HOMEPATH=\ HOSTTYPE=i686 IDLEIZER_HALT_ON_IDLE=true INPUTRC=C:/mozilla-build/msys/etc/inputrc LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOG="c:\runner\buildbot-startup.log" LOGNAME=cltbld LOGONSERVER=\\B-2008-SPOT-029 MACHTYPE=i686-pc-msys MAKE_MODE=unix MOZBUILDDIR=C:\mozilla-build MOZILLABUILD=C:\mozilla-build MOZ_AUTOMATION=1 MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_OBJDIR=obj-firefox MOZ_SIGNING_SERVERS=gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110 MOZ_SIGN_CMD=python /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/ash-w64-d-00000000000000000000/signing_cache -t /c/builds/moz2_slave/ash-w64-d-00000000000000000000/token -n /c/builds/moz2_slave/ash-w64-d-00000000000000000000/nonce -c /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110 MOZ_TOOLS=C:\mozilla-build\moztools-x64 MSYSTEM=MINGW32 NUMBER_OF_PROCESSORS=16 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\nsis-3.0b1;C:\mozilla-build\nsis-2.46u;C:\mozilla-build\python27;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\buildbotve\Scripts;c:\ProgramData\chocolatey\bin;.;c:\opt\runner;c:\mozilla-build\buildbotve;c:\mozilla-build\python27;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;.;C:\mozilla-build\msys\local\bin;c:\mozilla-build\moztools-x64\bin;c:\mozilla-build\vim\vim72 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 62 Stepping 4, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=3e04 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PROPERTIES_FILE=/c/builds/moz2_slave/ash-w64-d-00000000000000000000/buildprops.json PS1=\[\033]0;$MSYSTEM:\w\007 \033[32m\]\u@\h \[\033[33m\w\033[0m\] $ PSMODULEPATH=C:\Windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files (x86)\AWS Tools\PowerShell\ PUBLIC=C:\Users\Public PWD=c:/Users/cltbld RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg SHELL=C:/mozilla-build/msys/bin/sh SHLVL=1 SSH_AGENT_PID=2268 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048 SYSTEMDRIVE=C: SYSTEMROOT=C:\Windows TEMP=C:/Users/cltbld/AppData/Local/Temp TERM=cygwin TINDERBOX_OUTPUT=1 TMP=C:/Users/cltbld/AppData/Local/Temp TOOLTOOL_CACHE=/c/builds/tooltool_cache TOOLTOOL_HOME=/c/builds USERDOMAIN=B-2008-SPOT-029 USERNAME=cltbld USERPROFILE=C:\Users\cltbld VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\ VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\ VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\ WINDIR=C:\Windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log WIX_351728_PATH=c:/mozilla-build/wix-351728 XPCOM_DEBUG_BREAK=stack-and-abort _=C:\mozilla-build\buildbotve\Scripts\python using PTY: False 06:24:24 INFO - MultiFileLogger online at 20170220 06:24:24 in c:\builds\moz2_slave\ash-w64-d-00000000000000000000 06:24:24 INFO - Script was run with '--custom-build-variant-cfg debug' and 'debug' matches a key in 'builds/releng_sub_windows_configs/64_debug.py'. Updating self.config with items from that key's value. 06:24:24 INFO - Script was run with '--branch ash' and 'ash' matches a key in 'builds/branch_specifics.py'. Updating self.config with items from that key's value. 06:24:24 INFO - Script was run with '--build-pool production' and 'production' matches a key in 'builds/build_pool_specifics.py'. Updating self.config with items from that key's value. 06:24:24 INFO - To generate a config file based upon options passed and config files used, run script as before but extend options with "--dump-config" 06:24:24 INFO - For a diff of where self.config got its items, run the script again as before but extend options with: "--dump-config-hierarchy" 06:24:24 INFO - Both --dump-config and --dump-config-hierarchy don't actually run any actions. 06:24:24 INFO - We are running this in buildbot, grab the build props 06:24:24 INFO - Using buildbot properties: 06:24:24 INFO - { 06:24:24 INFO - "project": "", 06:24:24 INFO - "product": "firefox", 06:24:24 INFO - "script_repo_revision": "production", 06:24:24 INFO - "scheduler": "ash-firefox", 06:24:24 INFO - "repository": "", 06:24:24 INFO - "buildername": "WINNT 6.1 x86-64 ash leak test build", 06:24:24 INFO - "buildid": "20170220062259", 06:24:24 INFO - "basedir": "/c/builds/moz2_slave/ash-w64-d-00000000000000000000", 06:24:24 INFO - "buildnumber": 4, 06:24:24 INFO - "platform": "win64-debug", 06:24:24 INFO - "master": "http://buildbot-master94.bb.releng.use1.mozilla.com:8001/", 06:24:24 INFO - "branch": "ash", 06:24:24 INFO - "revision": "2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd", 06:24:24 INFO - "slavename": "b-2008-spot-029", 06:24:24 INFO - "builduid": "ba9a709595bd431b97418cb594d0bf2d", 06:24:24 INFO - "repo_path": "projects/ash" 06:24:24 INFO - } 06:24:24 INFO - Setting buildbot property stage_platform to win64-debug 06:24:24 INFO - mkdir: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\properties 06:24:24 INFO - Writing buildbot properties ['stage_platform'] to c:\builds\moz2_slave\ash-w64-d-00000000000000000000\properties\stage_platform 06:24:24 INFO - Writing to file c:\builds\moz2_slave\ash-w64-d-00000000000000000000\properties\stage_platform 06:24:24 INFO - Contents: 06:24:24 INFO - stage_platform:win64-debug 06:24:24 WARNING - Try message not found. 06:24:24 INFO - Run as scripts/scripts/fx_desktop_build.py --config builds/releng_base_windows_64_builds.py --custom-build-variant-cfg debug --config balrog/production.py --branch ash --build-pool production 06:24:24 INFO - Determining buildid from buildbot properties 06:24:24 INFO - Setting buildbot property buildid to 20170220062259 06:24:24 INFO - Writing buildbot properties ['buildid'] to c:\builds\moz2_slave\ash-w64-d-00000000000000000000\properties\buildid 06:24:24 INFO - Writing to file c:\builds\moz2_slave\ash-w64-d-00000000000000000000\properties\buildid 06:24:24 INFO - Contents: 06:24:24 INFO - buildid:20170220062259 06:24:24 INFO - Determining builduid from buildbot properties 06:24:24 INFO - Setting buildbot property builduid to ba9a709595bd431b97418cb594d0bf2d 06:24:24 INFO - Writing buildbot properties ['builduid'] to c:\builds\moz2_slave\ash-w64-d-00000000000000000000\properties\builduid 06:24:24 INFO - Writing to file c:\builds\moz2_slave\ash-w64-d-00000000000000000000\properties\builduid 06:24:24 INFO - Contents: 06:24:24 INFO - builduid:ba9a709595bd431b97418cb594d0bf2d 06:24:24 INFO - repo_path not in config. Using 'projects/ash' instead 06:24:24 INFO - Creating virtualenv c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv 06:24:24 INFO - mkdir: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build 06:24:24 INFO - Running command: ['c:\\mozilla-build\\python27\\python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\venv'] in c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build 06:24:24 INFO - Copy/paste: c:\mozilla-build\python27\python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv 06:24:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:24:27 INFO - New python executable in c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\Scripts\python.exe 06:24:31 INFO - Installing distribute................................................................................................................................................................................................done. 06:24:44 INFO - Installing pip....................................done. 06:24:44 INFO - Return code: 0 06:24:44 INFO - Getting output from command: ['c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\venv\\Scripts\\pip', '--version'] 06:24:44 INFO - Copy/paste: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\Scripts\pip --version 06:24:47 INFO - Reading from file tmpfile_stdout 06:24:47 INFO - Output received: 06:24:47 INFO - pip 9.0.1 from c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\lib\site-packages\pip-9.0.1-py2.7.egg (python 2.7) 06:24:47 INFO - Using _rmtree_windows ... 06:24:47 INFO - Using _rmtree_windows ... 06:24:47 INFO - Installing requests==2.8.1 into virtualenv c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv 06:24:47 INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'requests==2.8.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025DEDC8>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x026FB020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0250C700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x026C8798>, '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 0x0276B2A8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x022338A8>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build', 'env': {'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'MOZILLABUILD': 'C:\\mozilla-build', 'COMPUTERNAME': 'B-2008-SPOT-029', 'SYSTEMDRIVE': 'C:', 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 'USERDOMAIN': 'B-2008-SPOT-029', 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 'MOZ_AUTOMATION': '1', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'HOSTTYPE': 'i686', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'USERNAME': 'cltbld', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 'CVS_RSH': 'ssh', 'LOGNAME': 'cltbld', 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'SYSTEMROOT': 'C:\\Windows', 'USERPROFILE': 'C:\\Users\\cltbld', 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'MSYSTEM': 'MINGW32', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'MAKE_MODE': 'unix', 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 'SHELL': 'C:/mozilla-build/msys/bin/sh', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 'SHLVL': '1', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_ARCHITECTURE': 'x86', 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'EDITOR': 'emacs.exe', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'OSTYPE': 'msys', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'SSH_AGENT_PID': '2268', 'HOME': 'c:/Users/cltbld', 'PROGRAMW6432': 'C:\\Program Files', 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 'PROMPT': '$P$G', 'WINDOWS_TRACING_FLAGS': '3', 'PROCESSOR_REVISION': '3e04', 'PROGRAMDATA': 'C:\\ProgramData', 'LOG': '"c:\\runner\\buildbot-startup.log"', 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048', 'TERM': 'cygwin', 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\buildbotve\\Scripts;c:\\ProgramData\\chocolatey\\bin;.;c:\\opt\\runner;c:\\mozilla-build\\buildbotve;c:\\mozilla-build\\python27;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\msys\\local\\bin;.;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\moztools-x64\\bin;c:\\mozilla-build\\vim\\vim72', 'IDLEIZER_HALT_ON_IDLE': 'true', 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 'TINDERBOX_OUTPUT': '1', 'LOGONSERVER': '\\\\B-2008-SPOT-029', 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/ash-w64-d-00000000000000000000/signing_cache -t /c/builds/moz2_slave/ash-w64-d-00000000000000000000/token -n /c/builds/moz2_slave/ash-w64-d-00000000000000000000/nonce -c /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'HOMEPATH': '\\', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'FP_NO_HOST_CHECK': 'NO', 'WINDIR': 'C:\\Windows', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'HOMEDRIVE': 'C:', 'OS_VERSION': '2008', 'MOZBUILDDIR': 'C:\\mozilla-build', 'OLDPWD': 'c:/Users/cltbld', 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 'NUMBER_OF_PROCESSORS': '16', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'TOOLTOOL_HOME': '/c/builds', 'PWD': 'c:/Users/cltbld', 'PROCESSOR_LEVEL': '6', 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'PROGRAMFILES': 'C:\\Program Files (x86)'}}, attempt #1 06:24:47 INFO - Running command: ['c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'requests==2.8.1'] in c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build 06:24:47 INFO - Copy/paste: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\Scripts\pip install --timeout 120 requests==2.8.1 06:24:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:24:47 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 06:24:47 INFO - 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 06:24:47 INFO - 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 06:24:47 INFO - 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 06:24:47 INFO - 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 06:24:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:24:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:24:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:24:47 INFO - 'COMPUTERNAME': 'B-2008-SPOT-029', 06:24:47 INFO - 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 06:24:47 INFO - 'CVS_RSH': 'ssh', 06:24:47 INFO - 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 06:24:47 INFO - 'EDITOR': 'emacs.exe', 06:24:47 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:24:47 INFO - 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 06:24:47 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 06:24:47 INFO - 'HOME': 'c:/Users/cltbld', 06:24:47 INFO - 'HOMEDRIVE': 'C:', 06:24:47 INFO - 'HOMEPATH': '\\', 06:24:47 INFO - 'HOSTTYPE': 'i686', 06:24:47 INFO - 'IDLEIZER_HALT_ON_IDLE': 'true', 06:24:47 INFO - 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 06:24:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 06:24:47 INFO - 'LOG': '"c:\\runner\\buildbot-startup.log"', 06:24:47 INFO - 'LOGNAME': 'cltbld', 06:24:47 INFO - 'LOGONSERVER': '\\\\B-2008-SPOT-029', 06:24:47 INFO - 'MACHTYPE': 'i686-pc-msys', 06:24:47 INFO - 'MAKE_MODE': 'unix', 06:24:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build', 06:24:47 INFO - 'MOZILLABUILD': 'C:\\mozilla-build', 06:24:47 INFO - 'MOZ_AUTOMATION': '1', 06:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:47 INFO - 'MOZ_OBJDIR': 'obj-firefox', 06:24:47 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 06:24:47 INFO - 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/ash-w64-d-00000000000000000000/signing_cache -t /c/builds/moz2_slave/ash-w64-d-00000000000000000000/token -n /c/builds/moz2_slave/ash-w64-d-00000000000000000000/nonce -c /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 06:24:47 INFO - 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 06:24:47 INFO - 'MSYSTEM': 'MINGW32', 06:24:47 INFO - 'NUMBER_OF_PROCESSORS': '16', 06:24:47 INFO - 'OLDPWD': 'c:/Users/cltbld', 06:24:47 INFO - 'OS': 'Windows_NT', 06:24:47 INFO - 'OSTYPE': 'msys', 06:24:47 INFO - 'OS_VERSION': '2008', 06:24:47 INFO - 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\buildbotve\\Scripts;c:\\ProgramData\\chocolatey\\bin;.;c:\\opt\\runner;c:\\mozilla-build\\buildbotve;c:\\mozilla-build\\python27;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\msys\\local\\bin;.;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\moztools-x64\\bin;c:\\mozilla-build\\vim\\vim72', 06:24:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:24:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:24:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:24:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 06:24:47 INFO - 'PROCESSOR_LEVEL': '6', 06:24:47 INFO - 'PROCESSOR_REVISION': '3e04', 06:24:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:24:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:24:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:24:47 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:24:47 INFO - 'PROMPT': '$P$G', 06:24:47 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\buildprops.json', 06:24:47 INFO - 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 06:24:47 INFO - 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 06:24:47 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:24:47 INFO - 'PWD': 'c:/Users/cltbld', 06:24:47 INFO - 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 06:24:47 INFO - 'SHELL': 'C:/mozilla-build/msys/bin/sh', 06:24:47 INFO - 'SHLVL': '1', 06:24:47 INFO - 'SSH_AGENT_PID': '2268', 06:24:47 INFO - 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048', 06:24:47 INFO - 'SYSTEMDRIVE': 'C:', 06:24:47 INFO - 'SYSTEMROOT': 'C:\\Windows', 06:24:47 INFO - 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 06:24:47 INFO - 'TERM': 'cygwin', 06:24:47 INFO - 'TINDERBOX_OUTPUT': '1', 06:24:47 INFO - 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 06:24:47 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 06:24:47 INFO - 'TOOLTOOL_HOME': '/c/builds', 06:24:47 INFO - 'USERDOMAIN': 'B-2008-SPOT-029', 06:24:47 INFO - 'USERNAME': 'cltbld', 06:24:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 06:24:47 INFO - 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 06:24:47 INFO - 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 06:24:47 INFO - 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 06:24:47 INFO - 'WINDIR': 'C:\\Windows', 06:24:47 INFO - 'WINDOWS_TRACING_FLAGS': '3', 06:24:47 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 06:24:47 INFO - 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 06:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 06:24:47 INFO - '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'} 06:24:47 INFO - Collecting requests==2.8.1 06:24:48 INFO - Using cached requests-2.8.1-py2.py3-none-any.whl 06:24:48 INFO - Installing collected packages: requests 06:24:49 INFO - Successfully installed requests-2.8.1 06:24:50 INFO - c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\lib\site-packages\pip-9.0.1-py2.7.egg\pip\_vendor\requests\packages\urllib3\util\ssl_.py:318: 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/security.html#snimissingwarning. 06:24:50 INFO - SNIMissingWarning 06:24:50 INFO - c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\lib\site-packages\pip-9.0.1-py2.7.egg\pip\_vendor\requests\packages\urllib3\util\ssl_.py:122: 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/security.html#insecureplatformwarning. 06:24:50 INFO - InsecurePlatformWarning 06:24:50 INFO - c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\lib\site-packages\pip-9.0.1-py2.7.egg\pip\_vendor\requests\packages\urllib3\util\ssl_.py:122: 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/security.html#insecureplatformwarning. 06:24:50 INFO - InsecurePlatformWarning 06:24:50 INFO - Return code: 0 06:24:50 INFO - Installing PyHawk-with-a-single-extra-commit==0.1.5 into virtualenv c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv 06:24:50 INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'PyHawk-with-a-single-extra-commit==0.1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025DEDC8>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x026FB020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0250C700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x026C8798>, '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 0x0276B2A8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x022338A8>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build', 'env': {'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'MOZILLABUILD': 'C:\\mozilla-build', 'COMPUTERNAME': 'B-2008-SPOT-029', 'SYSTEMDRIVE': 'C:', 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 'USERDOMAIN': 'B-2008-SPOT-029', 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 'MOZ_AUTOMATION': '1', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'HOSTTYPE': 'i686', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'USERNAME': 'cltbld', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 'CVS_RSH': 'ssh', 'LOGNAME': 'cltbld', 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'SYSTEMROOT': 'C:\\Windows', 'USERPROFILE': 'C:\\Users\\cltbld', 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'MSYSTEM': 'MINGW32', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'MAKE_MODE': 'unix', 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 'SHELL': 'C:/mozilla-build/msys/bin/sh', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 'SHLVL': '1', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_ARCHITECTURE': 'x86', 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'EDITOR': 'emacs.exe', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'OSTYPE': 'msys', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'SSH_AGENT_PID': '2268', 'HOME': 'c:/Users/cltbld', 'PROGRAMW6432': 'C:\\Program Files', 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 'PROMPT': '$P$G', 'WINDOWS_TRACING_FLAGS': '3', 'PROCESSOR_REVISION': '3e04', 'PROGRAMDATA': 'C:\\ProgramData', 'LOG': '"c:\\runner\\buildbot-startup.log"', 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048', 'TERM': 'cygwin', 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\buildbotve\\Scripts;c:\\ProgramData\\chocolatey\\bin;.;c:\\opt\\runner;c:\\mozilla-build\\buildbotve;c:\\mozilla-build\\python27;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\msys\\local\\bin;.;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\moztools-x64\\bin;c:\\mozilla-build\\vim\\vim72', 'IDLEIZER_HALT_ON_IDLE': 'true', 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 'TINDERBOX_OUTPUT': '1', 'LOGONSERVER': '\\\\B-2008-SPOT-029', 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/ash-w64-d-00000000000000000000/signing_cache -t /c/builds/moz2_slave/ash-w64-d-00000000000000000000/token -n /c/builds/moz2_slave/ash-w64-d-00000000000000000000/nonce -c /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'HOMEPATH': '\\', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'FP_NO_HOST_CHECK': 'NO', 'WINDIR': 'C:\\Windows', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'HOMEDRIVE': 'C:', 'OS_VERSION': '2008', 'MOZBUILDDIR': 'C:\\mozilla-build', 'OLDPWD': 'c:/Users/cltbld', 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 'NUMBER_OF_PROCESSORS': '16', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'TOOLTOOL_HOME': '/c/builds', 'PWD': 'c:/Users/cltbld', 'PROCESSOR_LEVEL': '6', 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'PROGRAMFILES': 'C:\\Program Files (x86)'}}, attempt #1 06:24:50 INFO - Running command: ['c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'PyHawk-with-a-single-extra-commit==0.1.5'] in c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build 06:24:50 INFO - Copy/paste: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\Scripts\pip install --timeout 120 PyHawk-with-a-single-extra-commit==0.1.5 06:24:50 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:24:50 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 06:24:50 INFO - 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 06:24:50 INFO - 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 06:24:50 INFO - 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 06:24:50 INFO - 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 06:24:50 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:24:50 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:24:50 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:24:50 INFO - 'COMPUTERNAME': 'B-2008-SPOT-029', 06:24:50 INFO - 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 06:24:50 INFO - 'CVS_RSH': 'ssh', 06:24:50 INFO - 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 06:24:50 INFO - 'EDITOR': 'emacs.exe', 06:24:50 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:24:50 INFO - 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 06:24:50 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 06:24:50 INFO - 'HOME': 'c:/Users/cltbld', 06:24:50 INFO - 'HOMEDRIVE': 'C:', 06:24:50 INFO - 'HOMEPATH': '\\', 06:24:50 INFO - 'HOSTTYPE': 'i686', 06:24:50 INFO - 'IDLEIZER_HALT_ON_IDLE': 'true', 06:24:50 INFO - 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 06:24:50 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 06:24:50 INFO - 'LOG': '"c:\\runner\\buildbot-startup.log"', 06:24:50 INFO - 'LOGNAME': 'cltbld', 06:24:50 INFO - 'LOGONSERVER': '\\\\B-2008-SPOT-029', 06:24:50 INFO - 'MACHTYPE': 'i686-pc-msys', 06:24:50 INFO - 'MAKE_MODE': 'unix', 06:24:50 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build', 06:24:50 INFO - 'MOZILLABUILD': 'C:\\mozilla-build', 06:24:50 INFO - 'MOZ_AUTOMATION': '1', 06:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:50 INFO - 'MOZ_OBJDIR': 'obj-firefox', 06:24:50 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 06:24:50 INFO - 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/ash-w64-d-00000000000000000000/signing_cache -t /c/builds/moz2_slave/ash-w64-d-00000000000000000000/token -n /c/builds/moz2_slave/ash-w64-d-00000000000000000000/nonce -c /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 06:24:50 INFO - 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 06:24:50 INFO - 'MSYSTEM': 'MINGW32', 06:24:50 INFO - 'NUMBER_OF_PROCESSORS': '16', 06:24:50 INFO - 'OLDPWD': 'c:/Users/cltbld', 06:24:50 INFO - 'OS': 'Windows_NT', 06:24:50 INFO - 'OSTYPE': 'msys', 06:24:50 INFO - 'OS_VERSION': '2008', 06:24:50 INFO - 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\buildbotve\\Scripts;c:\\ProgramData\\chocolatey\\bin;.;c:\\opt\\runner;c:\\mozilla-build\\buildbotve;c:\\mozilla-build\\python27;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\msys\\local\\bin;.;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\moztools-x64\\bin;c:\\mozilla-build\\vim\\vim72', 06:24:50 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:24:50 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:24:50 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:24:50 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 06:24:50 INFO - 'PROCESSOR_LEVEL': '6', 06:24:50 INFO - 'PROCESSOR_REVISION': '3e04', 06:24:50 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:24:50 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:24:50 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:24:50 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:24:50 INFO - 'PROMPT': '$P$G', 06:24:50 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\buildprops.json', 06:24:50 INFO - 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 06:24:50 INFO - 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 06:24:50 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:24:50 INFO - 'PWD': 'c:/Users/cltbld', 06:24:50 INFO - 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 06:24:50 INFO - 'SHELL': 'C:/mozilla-build/msys/bin/sh', 06:24:50 INFO - 'SHLVL': '1', 06:24:50 INFO - 'SSH_AGENT_PID': '2268', 06:24:50 INFO - 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048', 06:24:50 INFO - 'SYSTEMDRIVE': 'C:', 06:24:50 INFO - 'SYSTEMROOT': 'C:\\Windows', 06:24:50 INFO - 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 06:24:50 INFO - 'TERM': 'cygwin', 06:24:50 INFO - 'TINDERBOX_OUTPUT': '1', 06:24:50 INFO - 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 06:24:50 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 06:24:50 INFO - 'TOOLTOOL_HOME': '/c/builds', 06:24:50 INFO - 'USERDOMAIN': 'B-2008-SPOT-029', 06:24:50 INFO - 'USERNAME': 'cltbld', 06:24:50 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 06:24:50 INFO - 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 06:24:50 INFO - 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 06:24:50 INFO - 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 06:24:50 INFO - 'WINDIR': 'C:\\Windows', 06:24:50 INFO - 'WINDOWS_TRACING_FLAGS': '3', 06:24:50 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 06:24:50 INFO - 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 06:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 06:24:50 INFO - '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'} 06:24:50 INFO - Collecting PyHawk-with-a-single-extra-commit==0.1.5 06:24:51 INFO - Using cached PyHawk-with-a-single-extra-commit-0.1.5.tar.gz 06:24:51 INFO - Installing collected packages: PyHawk-with-a-single-extra-commit 06:24:51 INFO - Running setup.py install for PyHawk-with-a-single-extra-commit: started 06:24:52 INFO - Running setup.py install for PyHawk-with-a-single-extra-commit: finished with status 'done' 06:24:52 INFO - Successfully installed PyHawk-with-a-single-extra-commit-0.1.5 06:24:52 INFO - c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\lib\site-packages\pip-9.0.1-py2.7.egg\pip\_vendor\requests\packages\urllib3\util\ssl_.py:318: 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/security.html#snimissingwarning. 06:24:52 INFO - SNIMissingWarning 06:24:52 INFO - c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\lib\site-packages\pip-9.0.1-py2.7.egg\pip\_vendor\requests\packages\urllib3\util\ssl_.py:122: 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/security.html#insecureplatformwarning. 06:24:52 INFO - InsecurePlatformWarning 06:24:52 INFO - Return code: 0 06:24:52 INFO - Installing taskcluster==0.0.26 into virtualenv c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv 06:24:52 INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'taskcluster==0.0.26']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025DEDC8>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x026FB020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0250C700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x026C8798>, '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 0x0276B2A8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x022338A8>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build', 'env': {'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'MOZILLABUILD': 'C:\\mozilla-build', 'COMPUTERNAME': 'B-2008-SPOT-029', 'SYSTEMDRIVE': 'C:', 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 'USERDOMAIN': 'B-2008-SPOT-029', 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 'MOZ_AUTOMATION': '1', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'HOSTTYPE': 'i686', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'USERNAME': 'cltbld', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 'CVS_RSH': 'ssh', 'LOGNAME': 'cltbld', 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'SYSTEMROOT': 'C:\\Windows', 'USERPROFILE': 'C:\\Users\\cltbld', 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'MSYSTEM': 'MINGW32', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'MAKE_MODE': 'unix', 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 'SHELL': 'C:/mozilla-build/msys/bin/sh', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 'SHLVL': '1', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_ARCHITECTURE': 'x86', 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'EDITOR': 'emacs.exe', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'OSTYPE': 'msys', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'SSH_AGENT_PID': '2268', 'HOME': 'c:/Users/cltbld', 'PROGRAMW6432': 'C:\\Program Files', 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 'PROMPT': '$P$G', 'WINDOWS_TRACING_FLAGS': '3', 'PROCESSOR_REVISION': '3e04', 'PROGRAMDATA': 'C:\\ProgramData', 'LOG': '"c:\\runner\\buildbot-startup.log"', 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048', 'TERM': 'cygwin', 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\buildbotve\\Scripts;c:\\ProgramData\\chocolatey\\bin;.;c:\\opt\\runner;c:\\mozilla-build\\buildbotve;c:\\mozilla-build\\python27;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\msys\\local\\bin;.;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\moztools-x64\\bin;c:\\mozilla-build\\vim\\vim72', 'IDLEIZER_HALT_ON_IDLE': 'true', 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 'TINDERBOX_OUTPUT': '1', 'LOGONSERVER': '\\\\B-2008-SPOT-029', 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/ash-w64-d-00000000000000000000/signing_cache -t /c/builds/moz2_slave/ash-w64-d-00000000000000000000/token -n /c/builds/moz2_slave/ash-w64-d-00000000000000000000/nonce -c /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'HOMEPATH': '\\', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'FP_NO_HOST_CHECK': 'NO', 'WINDIR': 'C:\\Windows', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'HOMEDRIVE': 'C:', 'OS_VERSION': '2008', 'MOZBUILDDIR': 'C:\\mozilla-build', 'OLDPWD': 'c:/Users/cltbld', 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 'NUMBER_OF_PROCESSORS': '16', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'TOOLTOOL_HOME': '/c/builds', 'PWD': 'c:/Users/cltbld', 'PROCESSOR_LEVEL': '6', 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'PROGRAMFILES': 'C:\\Program Files (x86)'}}, attempt #1 06:24:52 INFO - Running command: ['c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'taskcluster==0.0.26'] in c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build 06:24:52 INFO - Copy/paste: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\Scripts\pip install --timeout 120 taskcluster==0.0.26 06:24:52 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:24:52 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 06:24:52 INFO - 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 06:24:52 INFO - 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 06:24:52 INFO - 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 06:24:52 INFO - 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 06:24:52 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:24:52 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:24:52 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:24:52 INFO - 'COMPUTERNAME': 'B-2008-SPOT-029', 06:24:52 INFO - 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 06:24:52 INFO - 'CVS_RSH': 'ssh', 06:24:52 INFO - 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 06:24:52 INFO - 'EDITOR': 'emacs.exe', 06:24:52 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:24:52 INFO - 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 06:24:52 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 06:24:52 INFO - 'HOME': 'c:/Users/cltbld', 06:24:52 INFO - 'HOMEDRIVE': 'C:', 06:24:52 INFO - 'HOMEPATH': '\\', 06:24:52 INFO - 'HOSTTYPE': 'i686', 06:24:52 INFO - 'IDLEIZER_HALT_ON_IDLE': 'true', 06:24:52 INFO - 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 06:24:52 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 06:24:52 INFO - 'LOG': '"c:\\runner\\buildbot-startup.log"', 06:24:52 INFO - 'LOGNAME': 'cltbld', 06:24:52 INFO - 'LOGONSERVER': '\\\\B-2008-SPOT-029', 06:24:52 INFO - 'MACHTYPE': 'i686-pc-msys', 06:24:52 INFO - 'MAKE_MODE': 'unix', 06:24:52 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build', 06:24:52 INFO - 'MOZILLABUILD': 'C:\\mozilla-build', 06:24:52 INFO - 'MOZ_AUTOMATION': '1', 06:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:52 INFO - 'MOZ_OBJDIR': 'obj-firefox', 06:24:52 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 06:24:52 INFO - 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/ash-w64-d-00000000000000000000/signing_cache -t /c/builds/moz2_slave/ash-w64-d-00000000000000000000/token -n /c/builds/moz2_slave/ash-w64-d-00000000000000000000/nonce -c /c/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 06:24:52 INFO - 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 06:24:52 INFO - 'MSYSTEM': 'MINGW32', 06:24:52 INFO - 'NUMBER_OF_PROCESSORS': '16', 06:24:52 INFO - 'OLDPWD': 'c:/Users/cltbld', 06:24:52 INFO - 'OS': 'Windows_NT', 06:24:52 INFO - 'OSTYPE': 'msys', 06:24:52 INFO - 'OS_VERSION': '2008', 06:24:52 INFO - 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\buildbotve\\Scripts;c:\\ProgramData\\chocolatey\\bin;.;c:\\opt\\runner;c:\\mozilla-build\\buildbotve;c:\\mozilla-build\\python27;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\msys\\local\\bin;.;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\moztools-x64\\bin;c:\\mozilla-build\\vim\\vim72', 06:24:52 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:24:52 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:24:52 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:24:52 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 06:24:52 INFO - 'PROCESSOR_LEVEL': '6', 06:24:52 INFO - 'PROCESSOR_REVISION': '3e04', 06:24:52 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:24:52 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:24:52 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:24:52 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:24:52 INFO - 'PROMPT': '$P$G', 06:24:52 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\buildprops.json', 06:24:52 INFO - 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 06:24:52 INFO - 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 06:24:52 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:24:52 INFO - 'PWD': 'c:/Users/cltbld', 06:24:52 INFO - 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 06:24:52 INFO - 'SHELL': 'C:/mozilla-build/msys/bin/sh', 06:24:52 INFO - 'SHLVL': '1', 06:24:52 INFO - 'SSH_AGENT_PID': '2268', 06:24:52 INFO - 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048', 06:24:52 INFO - 'SYSTEMDRIVE': 'C:', 06:24:52 INFO - 'SYSTEMROOT': 'C:\\Windows', 06:24:52 INFO - 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 06:24:52 INFO - 'TERM': 'cygwin', 06:24:52 INFO - 'TINDERBOX_OUTPUT': '1', 06:24:52 INFO - 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 06:24:52 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 06:24:52 INFO - 'TOOLTOOL_HOME': '/c/builds', 06:24:52 INFO - 'USERDOMAIN': 'B-2008-SPOT-029', 06:24:52 INFO - 'USERNAME': 'cltbld', 06:24:52 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 06:24:52 INFO - 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 06:24:52 INFO - 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 06:24:52 INFO - 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 06:24:52 INFO - 'WINDIR': 'C:\\Windows', 06:24:52 INFO - 'WINDOWS_TRACING_FLAGS': '3', 06:24:52 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 06:24:52 INFO - 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 06:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 06:24:52 INFO - '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'} 06:24:52 INFO - Collecting taskcluster==0.0.26 06:24:53 INFO - Using cached taskcluster-0.0.26.tar.gz 06:24:53 INFO - Collecting requests<=2.7.0,>=2.4.3 (from taskcluster==0.0.26) 06:24:54 INFO - Using cached requests-2.7.0-py2.py3-none-any.whl 06:24:54 INFO - Requirement already satisfied: PyHawk_with_a_single_extra_commit==0.1.5 in .\venv\lib\site-packages (from taskcluster==0.0.26) 06:24:54 INFO - Collecting slugid (from taskcluster==0.0.26) 06:24:54 INFO - Using cached slugid-1.0.7.tar.gz 06:24:54 INFO - Installing collected packages: requests, slugid, taskcluster 06:24:54 INFO - Found existing installation: requests 2.8.1 06:24:54 INFO - Uninstalling requests-2.8.1: 06:24:54 INFO - Successfully uninstalled requests-2.8.1 06:24:55 INFO - Running setup.py install for slugid: started 06:24:56 INFO - Running setup.py install for slugid: finished with status 'done' 06:24:56 INFO - Running setup.py install for taskcluster: started 06:24:56 INFO - Running setup.py install for taskcluster: finished with status 'done' 06:24:56 INFO - Successfully installed requests-2.7.0 slugid-1.0.7 taskcluster-0.0.26 06:24:57 INFO - c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\lib\site-packages\pip-9.0.1-py2.7.egg\pip\_vendor\requests\packages\urllib3\util\ssl_.py:318: 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/security.html#snimissingwarning. 06:24:57 INFO - SNIMissingWarning 06:24:57 INFO - c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\lib\site-packages\pip-9.0.1-py2.7.egg\pip\_vendor\requests\packages\urllib3\util\ssl_.py:122: 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/security.html#insecureplatformwarning. 06:24:57 INFO - InsecurePlatformWarning 06:24:57 INFO - Return code: 0 06:24:57 INFO - Done creating virtualenv c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv. 06:24:57 INFO - Getting output from command: ['c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\venv\\Scripts\\pip', 'freeze'] 06:24:57 INFO - Copy/paste: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\venv\Scripts\pip freeze 06:24:57 INFO - Reading from file tmpfile_stdout 06:24:57 INFO - Using _rmtree_windows ... 06:24:57 INFO - Using _rmtree_windows ... 06:24:57 INFO - Current package versions: 06:24:57 INFO - PyHawk-with-a-single-extra-commit == 0.1.5 06:24:57 INFO - requests == 2.7.0 06:24:57 INFO - slugid == 1.0.7 06:24:57 INFO - taskcluster == 0.0.26 06:24:57 INFO - Running pre-run listener: suppress_windows_modal_dialogs 06:24:57 INFO - Dumping config to c:\builds\moz2_slave\ash-w64-d-00000000000000000000\logs\localconfig.json. 06:24:57 INFO - {'app_ini_path': '%(obj_dir)s/dist/bin/application.ini', 06:24:57 INFO - 'append_to_log': False, 06:24:57 INFO - 'balrog_credentials_file': 'oauth.txt', 06:24:57 INFO - 'balrog_servers': ({'balrog_api_root': 'https://aus4-admin.mozilla.org/api', 06:24:57 INFO - 'balrog_usernames': {'Fennec': 'ffxbld', 06:24:57 INFO - 'firefox': 'ffxbld', 06:24:57 INFO - 'mobile': 'ffxbld', 06:24:57 INFO - 'thunderbird': 'tbirdbld'}, 06:24:57 INFO - 'ignore_failures': False, 06:24:57 INFO - 'url_replacements': (('http://archive.mozilla.org/pub', 06:24:57 INFO - 'http://download.cdn.mozilla.net/pub'),)},), 06:24:57 INFO - 'base_name': 'WINNT_6.1_x86-64_%(branch)s', 06:24:57 INFO - 'base_work_dir': 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000', 06:24:57 INFO - 'branch': 'ash', 06:24:57 INFO - 'build_pool': 'production', 06:24:57 INFO - 'build_resources_path': '%(abs_src_dir)s/obj-firefox/.mozbuild/build_resources.json', 06:24:57 INFO - 'build_variant': 'debug', 06:24:57 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:57 INFO - 'check_test_env': {'MINIDUMP_SAVE_PATH': '%(base_work_dir)s/minidumps', 06:24:57 INFO - 'MINIDUMP_STACKWALK': '%(abs_tools_dir)s/breakpad/win64/minidump_stackwalk.exe'}, 06:24:57 INFO - 'clobberer_url': 'https://api.pub.build.mozilla.org/clobberer/lastclobber', 06:24:57 INFO - 'clone_by_revision': False, 06:24:57 INFO - 'clone_with_purge': False, 06:24:57 INFO - 'config_files': ('builds/releng_base_windows_64_builds.py', 06:24:57 INFO - 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\scripts\\scripts\\..\\configs\\builds/releng_sub_windows_configs/64_debug.py', 06:24:57 INFO - 'balrog/production.py', 06:24:57 INFO - 'builds/branch_specifics.py', 06:24:57 INFO - 'builds/build_pool_specifics.py'), 06:24:57 INFO - 'debug_build': True, 06:24:57 INFO - 'default_actions': ('clobber', 06:24:57 INFO - 'clone-tools', 06:24:57 INFO - 'checkout-sources', 06:24:57 INFO - 'build', 06:24:57 INFO - 'upload-files', 06:24:57 INFO - 'sendchange', 06:24:57 INFO - 'check-test', 06:24:57 INFO - 'generate-build-stats', 06:24:57 INFO - 'update'), 06:24:57 INFO - 'enable_ccache': False, 06:24:57 INFO - 'enable_count_ctors': False, 06:24:57 INFO - 'enable_pymake': True, 06:24:57 INFO - 'enable_signing': True, 06:24:57 INFO - 'enable_talos_sendchange': False, 06:24:57 INFO - 'enable_unittest_sendchange': True, 06:24:57 INFO - 'env': {'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 06:24:57 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 06:24:57 INFO - 'MOZ_AUTOMATION': '1', 06:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:57 INFO - 'MOZ_OBJDIR': 'obj-firefox', 06:24:57 INFO - 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\buildbotve\\Scripts;c:\\ProgramData\\chocolatey\\bin;.;c:\\opt\\runner;c:\\mozilla-build\\buildbotve;c:\\mozilla-build\\python27;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\msys\\local\\bin;.;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\moztools-x64\\bin;c:\\mozilla-build\\vim\\vim72', 06:24:57 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\buildprops.json', 06:24:57 INFO - 'TINDERBOX_OUTPUT': '1', 06:24:57 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 06:24:57 INFO - 'TOOLTOOL_HOME': '/c/builds', 06:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'stack-and-abort'}, 06:24:57 INFO - 'exes': {'buildbot': ('c:\\mozilla-build\\python27\\python.exe', 06:24:57 INFO - 'c:\\mozilla-build\\buildbotve\\scripts\\buildbot'), 06:24:57 INFO - 'make': ('c:\\mozilla-build\\python27\\python.exe', 06:24:57 INFO - 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src\\build\\pymake\\make.py'), 06:24:57 INFO - 'python2.7': 'c:\\mozilla-build\\python27\\python.exe', 06:24:57 INFO - 'virtualenv': ('c:\\mozilla-build\\python27\\python.exe', 06:24:57 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 06:24:57 INFO - 'graph_selector': '/server/collect.cgi', 06:24:57 INFO - 'graph_server': 'graphs.mozilla.org', 06:24:57 INFO - 'include_post_upload_builddir': False, 06:24:57 INFO - 'is_automation': True, 06:24:57 INFO - 'log_level': 'info', 06:24:57 INFO - 'log_to_console': True, 06:24:57 INFO - 'max_build_output_timeout': 4800, 06:24:57 INFO - 'nightly_build': False, 06:24:57 INFO - 'nightly_promotion_branches': ('mozilla-central', 'mozilla-aurora'), 06:24:57 INFO - 'objdir': 'obj-firefox', 06:24:57 INFO - 'old_packages': ('%(objdir)s/dist/firefox-*', 06:24:57 INFO - '%(objdir)s/dist/fennec*', 06:24:57 INFO - '%(objdir)s/dist/seamonkey*', 06:24:57 INFO - '%(objdir)s/dist/thunderbird*', 06:24:57 INFO - '%(objdir)s/dist/install/sea/*.exe'), 06:24:57 INFO - 'opt_config_files': (), 06:24:57 INFO - 'periodic_clobber': 168, 06:24:57 INFO - 'pgo_build': False, 06:24:57 INFO - 'pgo_platforms': ('linux', 'linux64', 'win32', 'win64'), 06:24:57 INFO - 'platform': 'win64', 06:24:57 INFO - 'platform_supports_post_upload_to_latest': True, 06:24:57 INFO - 'publish_nightly_en_US_routes': True, 06:24:57 INFO - 'release_to_try_builds': False, 06:24:57 INFO - 'repo_base': 'https://hg.mozilla.org', 06:24:57 INFO - 'scm_level': 1, 06:24:57 INFO - 'sendchange_masters': ('buildbot-master81.build.mozilla.org:9301',), 06:24:57 INFO - 'src_mozconfig': 'browser/config/mozconfigs/win64/debug', 06:24:57 INFO - 'stage_platform': 'win64-debug', 06:24:57 INFO - 'stage_product': 'firefox', 06:24:57 INFO - 'stage_server': 'upload.ffxbld.productdelivery.prod.mozaws.net', 06:24:57 INFO - 'stage_ssh_key': 'ffxbld_rsa', 06:24:57 INFO - 'stage_username': 'ffxbld', 06:24:57 INFO - 'taskcluster_credentials_file': 'oauth.txt', 06:24:57 INFO - 'taskcluster_index': 'index', 06:24:57 INFO - 'tinderbox_build_dir': None, 06:24:57 INFO - 'to_tinderbox_dated': True, 06:24:57 INFO - 'tools_repo': 'https://hg.mozilla.org/build/tools', 06:24:57 INFO - 'tooltool_bootstrap': 'setup.sh', 06:24:57 INFO - 'tooltool_manifest_src': 'browser/config/tooltool-manifests/win64/releng.manifest', 06:24:57 INFO - 'tooltool_script': ('c:\\mozilla-build\\python27\\python.exe', 06:24:57 INFO - 'C:/mozilla-build/tooltool.py'), 06:24:57 INFO - 'tooltool_url': 'https://api.pub.build.mozilla.org/tooltool/', 06:24:57 INFO - 'upload_env': {'UPLOAD_HOST': '%(stage_server)s', 06:24:57 INFO - 'UPLOAD_SSH_KEY': '/c/Users/cltbld/.ssh/%(stage_ssh_key)s', 06:24:57 INFO - 'UPLOAD_TO_TEMP': '1', 06:24:57 INFO - 'UPLOAD_USER': '%(stage_username)s'}, 06:24:57 INFO - 'use_clobberer': True, 06:24:57 INFO - 'vcs_share_base': 'C:/builds/hg-shared', 06:24:57 INFO - 'virtualenv_modules': ('requests==2.8.1', 06:24:57 INFO - 'PyHawk-with-a-single-extra-commit==0.1.5', 06:24:57 INFO - 'taskcluster==0.0.26'), 06:24:57 INFO - 'virtualenv_path': 'venv', 06:24:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:57 INFO - 'who': '', 06:24:57 INFO - 'work_dir': 'build'} 06:24:57 INFO - [mozharness: 2017-02-20 14:24:57.856000Z] Skipping get-secrets step. 06:24:57 INFO - [mozharness: 2017-02-20 14:24:57.856000Z] Running clobber step. 06:24:57 INFO - Running main action method: clobber 06:24:57 INFO - retry: Calling run_command with args: [['python', 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\scripts\\external_tools\\clobberer.py', '-s', 'scripts', '-s', 'logs', '-s', 'buildprops.json', '-s', 'token', '-s', 'oauth.txt', '-t', '168', 'https://api.pub.build.mozilla.org/clobberer/lastclobber', u'ash', u'WINNT 6.1 x86-64 ash leak test build', 'ash-w64-d-00000000000000000000', u'b-2008-spot-029', u'http://buildbot-master94.bb.releng.use1.mozilla.com:8001/']], kwargs: {'error_list': [{'substr': 'Error contacting server', 'explanation': 'Error contacting server for clobberer information.', 'level': 'error'}], 'cwd': 'c:\\builds\\moz2_slave'}, attempt #1 06:24:57 INFO - Running command: ['python', 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\scripts\\external_tools\\clobberer.py', '-s', 'scripts', '-s', 'logs', '-s', 'buildprops.json', '-s', 'token', '-s', 'oauth.txt', '-t', '168', 'https://api.pub.build.mozilla.org/clobberer/lastclobber', u'ash', u'WINNT 6.1 x86-64 ash leak test build', 'ash-w64-d-00000000000000000000', u'b-2008-spot-029', u'http://buildbot-master94.bb.releng.use1.mozilla.com:8001/'] in c:\builds\moz2_slave 06:24:57 INFO - Copy/paste: python c:\builds\moz2_slave\ash-w64-d-00000000000000000000\scripts\external_tools\clobberer.py -s scripts -s logs -s buildprops.json -s token -s oauth.txt -t 168 https://api.pub.build.mozilla.org/clobberer/lastclobber ash "WINNT 6.1 x86-64 ash leak test build" ash-w64-d-00000000000000000000 b-2008-spot-029 http://buildbot-master94.bb.releng.use1.mozilla.com:8001/ 06:24:58 INFO - Checking clobber URL: https://api.pub.build.mozilla.org/clobberer/lastclobber?master=http%3A%2F%2Fbuildbot-master94.bb.releng.use1.mozilla.com%3A8001%2F&slave=b-2008-spot-029&builddir=ash-w64-d-00000000000000000000&branch=ash&buildername=WINNT+6.1+x86-64+ash+leak+test+build 06:24:58 INFO - ash-w64-d-00000000000000000000:Our last clobber date: None 06:24:58 INFO - ash-w64-d-00000000000000000000:Server clobber date: None 06:24:58 INFO - TinderboxPrint: purged clobber 06:24:58 INFO - Return code: 0 06:24:58 INFO - [mozharness: 2017-02-20 14:24:58.530000Z] Finished clobber step (success) 06:24:58 INFO - [mozharness: 2017-02-20 14:24:58.531000Z] Running clone-tools step. 06:24:58 INFO - Running main action method: clone_tools 06:24:58 INFO - retry: Calling _get_revision with args: (, 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\tools'), kwargs: {}, attempt #1 06:24:58 WARNING - did not specify revision or branch; assuming "default" 06:24:58 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version'] 06:24:58 INFO - Copy/paste: hg --config ui.merge=internal:merge --version 06:24:59 INFO - Mercurial Distributed SCM (version 3.9.1) 06:24:59 INFO - (see https://mercurial-scm.org for more information) 06:24:59 INFO - Copyright (C) 2005-2016 Matt Mackall and others 06:24:59 INFO - This is free software; see the source for copying conditions. There is NO 06:24:59 INFO - warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. 06:24:59 INFO - Return code: 0 06:24:59 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall'] 06:24:59 INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall 06:25:00 INFO - checking encoding (cp1252)... 06:25:00 INFO - checking Python executable (c:\mozilla-build\hg\hg.exe) 06:25:00 INFO - checking Python version (2.7.12) 06:25:00 INFO - checking Python lib (c:\mozilla-build\hg\lib\library.zip)... 06:25:00 INFO - checking Mercurial version (3.9.1) 06:25:00 INFO - checking Mercurial custom build () 06:25:00 INFO - checking module policy (c) 06:25:00 INFO - checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)... 06:25:00 INFO - checking templates (c:\mozilla-build\hg\templates)... 06:25:00 INFO - checking default template (c:\mozilla-build\hg\templates\map-cmdline.default) 06:25:00 INFO - checking commit editor... (notepad) 06:25:00 INFO - checking username (Mozilla Release Engineering ) 06:25:00 INFO - no problems detected 06:25:00 INFO - Return code: 0 06:25:00 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/build/tools', 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\tools', '--sharebase', 'C:/builds/hg-shared', '--branch', 'default'] 06:25:00 INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\ash-w64-d-00000000000000000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/build/tools c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\tools --sharebase C:/builds/hg-shared --branch default 06:25:02 INFO - ensuring https://hg.mozilla.org/build/tools@default is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\tools 06:25:02 INFO - (sharing from existing pooled repository 7ae7fb134bf7aec6ec96a062ff47a69053dd2973) 06:25:02 INFO - searching for changes 06:25:02 INFO - no changes found 06:25:02 INFO - (pulling to obtain default) 06:25:02 INFO - (remote resolved default to b62c0d32dd1c7b5761acd485c49b506ce3522035; result is not deterministic) 06:25:02 INFO - (revision already present locally; not pulling) 06:25:05 INFO - 06:25:05 INFO - updating [===================================================> ] 900/937 01s 06:25:05 INFO - 06:25:05 INFO - 937 files updated, 0 files merged, 0 files removed, 0 files unresolved 06:25:05 INFO - updated to b62c0d32dd1c7b5761acd485c49b506ce3522035 06:25:06 INFO - Return code: 0 06:25:06 INFO - [mozharness: 2017-02-20 14:25:06.001000Z] Finished clone-tools step (success) 06:25:06 INFO - [mozharness: 2017-02-20 14:25:06.001000Z] Running checkout-sources step. 06:25:06 INFO - Running main action method: checkout_sources 06:25:06 INFO - retry: Calling _get_revision with args: (, 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src'), kwargs: {}, attempt #1 06:25:06 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version'] 06:25:06 INFO - Copy/paste: hg --config ui.merge=internal:merge --version 06:25:06 INFO - Mercurial Distributed SCM (version 3.9.1) 06:25:06 INFO - (see https://mercurial-scm.org for more information) 06:25:06 INFO - Copyright (C) 2005-2016 Matt Mackall and others 06:25:06 INFO - This is free software; see the source for copying conditions. There is NO 06:25:06 INFO - warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. 06:25:06 INFO - Return code: 0 06:25:06 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall'] 06:25:06 INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall 06:25:06 INFO - checking encoding (cp1252)... 06:25:06 INFO - checking Python executable (c:\mozilla-build\hg\hg.exe) 06:25:06 INFO - checking Python version (2.7.12) 06:25:06 INFO - checking Python lib (c:\mozilla-build\hg\lib\library.zip)... 06:25:06 INFO - checking Mercurial version (3.9.1) 06:25:06 INFO - checking Mercurial custom build () 06:25:06 INFO - checking module policy (c) 06:25:06 INFO - checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)... 06:25:06 INFO - checking templates (c:\mozilla-build\hg\templates)... 06:25:06 INFO - checking default template (c:\mozilla-build\hg\templates\map-cmdline.default) 06:25:06 INFO - checking commit editor... (notepad) 06:25:06 INFO - checking username (Mozilla Release Engineering ) 06:25:06 INFO - no problems detected 06:25:06 INFO - Return code: 0 06:25:06 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/projects/ash', 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src', '--sharebase', 'C:/builds/hg-shared', '--revision', '2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd'] 06:25:06 INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\ash-w64-d-00000000000000000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/projects/ash c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src --sharebase C:/builds/hg-shared --revision 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd 06:26:46 INFO - 06:26:46 INFO - searching [ <=> ] 3 06:26:46 INFO - searching [ <=> ] 5 06:26:46 INFO - 06:26:46 INFO - 06:26:46 INFO - changesets [===============> ] 4238/13343 06:26:46 INFO - changesets [===========================> ] 7774/13343 02s 06:26:46 INFO - changesets [======================================> ] 10652/13343 01s 06:26:46 INFO - changesets [==============================================> ] 13036/13343 01s 06:26:46 INFO - 06:26:46 INFO - 06:26:46 INFO - manifests [ ] 4/13343 2h38m 06:26:46 INFO - manifests [ ] 6/13343 2h33m 06:26:46 INFO - manifests [ ] 8/13343 2h32m 06:26:46 INFO - manifests [ ] 10/13343 2h31m 06:26:46 INFO - manifests [ ] 12/13343 2h31m 06:26:46 INFO - manifests [ ] 14/13343 2h31m 06:26:46 INFO - manifests [ ] 16/13343 2h31m 06:26:46 INFO - manifests [ ] 18/13343 2h31m 06:26:46 INFO - manifests [ ] 20/13343 2h32m 06:26:46 INFO - manifests [ ] 22/13343 2h32m 06:26:46 INFO - manifests [ ] 30/13343 2h01m 06:26:46 INFO - manifests [ ] 32/13343 2h04m 06:26:46 INFO - manifests [ ] 37/13343 1h55m 06:26:46 INFO - manifests [ ] 40/13343 1h55m 06:26:46 INFO - manifests [ ] 42/13343 1h57m 06:26:46 INFO - manifests [ ] 44/13343 1h59m 06:26:46 INFO - manifests [ ] 46/13343 2h02m 06:26:46 INFO - manifests [ ] 48/13343 2h04m 06:26:46 INFO - manifests [ ] 50/13343 2h07m 06:26:46 INFO - manifests [ ] 52/13343 2h09m 06:26:46 INFO - manifests [ ] 54/13343 2h11m 06:26:46 INFO - manifests [ ] 56/13343 2h13m 06:26:46 INFO - manifests [ ] 58/13343 2h15m 06:26:46 INFO - manifests [ ] 60/13343 2h17m 06:26:46 INFO - manifests [ ] 62/13343 2h19m 06:26:46 INFO - manifests [ ] 64/13343 2h20m 06:26:46 INFO - manifests [ ] 66/13343 2h22m 06:26:46 INFO - manifests [ ] 68/13343 2h24m 06:26:46 INFO - manifests [ ] 70/13343 2h25m 06:26:46 INFO - manifests [ ] 72/13343 2h27m 06:26:46 INFO - manifests [ ] 74/13343 2h28m 06:26:46 INFO - manifests [ ] 76/13343 2h30m 06:26:46 INFO - manifests [ ] 78/13343 2h31m 06:26:46 INFO - manifests [ ] 80/13343 2h33m 06:26:46 INFO - manifests [ ] 82/13343 2h34m 06:26:46 INFO - manifests [ ] 84/13343 2h35m 06:26:46 INFO - manifests [ ] 86/13343 2h37m 06:26:46 INFO - manifests [ ] 88/13343 2h38m 06:26:46 INFO - manifests [ ] 90/13343 2h39m 06:26:46 INFO - manifests [ ] 92/13343 2h41m 06:26:46 INFO - manifests [ ] 93/13343 2h41m 06:26:46 INFO - manifests [ ] 94/13343 2h42m 06:26:46 INFO - manifests [ ] 95/13343 2h43m 06:26:46 INFO - manifests [ ] 96/13343 2h43m 06:26:46 INFO - manifests [ ] 99/13343 2h41m 06:26:46 INFO - manifests [==> ] 1005/13343 14m49s 06:26:46 INFO - manifests [=========================> ] 7276/13343 1m02s 06:26:46 INFO - manifests [=====================================> ] 10240/13343 23s 06:26:46 INFO - manifests [===========================================> ] 11833/13343 10sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:26:46 INFO - (sharing from existing pooled repository 8ba995b74e18334ab3707f27e9eb8f4e37ba3d29) 06:26:46 INFO - searching for changes 06:26:46 INFO - adding changesets 06:26:46 INFO - adding manifests 06:26:46 INFO - 06:26:46 INFO - 06:26:46 INFO - transaction abort! 06:26:46 INFO - rollback completed 06:26:47 INFO - stream ended unexpectedly (got 0 bytes, expected 4) 06:26:47 INFO - (retrying after network failure on attempt 1 of 3) 06:26:47 INFO - (waiting 4.34s before retry) 06:29:22 INFO - 06:29:22 INFO - searching [ <=> ] 2 06:29:22 INFO - searching [ <=> ] 3 06:29:22 INFO - searching [ <=> ] 5 06:29:22 INFO - 06:29:22 INFO - 06:29:22 INFO - changesets [ ] 1/13343 06:29:22 INFO - changesets [============> ] 3494/13343 06:29:22 INFO - changesets [==========================> ] 6871/13343 06:29:22 INFO - changesets [==================================> ] 9699/13343 02s 06:29:22 INFO - changesets [==========================================> ] 11932/13343 01s 06:29:22 INFO - 06:29:22 INFO - 06:29:22 INFO - manifests [ ] 1/13343 06:29:22 INFO - manifests [ ] 3/13343 11d02h 06:29:22 INFO - manifests [ ] 5/13343 5d15h 06:29:22 INFO - manifests [ ] 7/13343 3d19h 06:29:22 INFO - manifests [ ] 9/13343 2d21h 06:29:22 INFO - manifests [ ] 11/13343 2d08h 06:29:22 INFO - manifests [ ] 13/13343 1d23h 06:29:22 INFO - manifests [ ] 15/13343 1d17h 06:29:22 INFO - manifests [ ] 17/13343 1d12h 06:29:22 INFO - manifests [ ] 19/13343 1d08h 06:29:22 INFO - manifests [ ] 21/13343 28h45m 06:29:22 INFO - manifests [ ] 25/13343 24h10m 06:29:22 INFO - manifests [ ] 31/13343 19h30m 06:29:22 INFO - manifests [ ] 36/13343 16h52m 06:29:22 INFO - manifests [ ] 38/13343 16h06m 06:29:22 INFO - manifests [ ] 41/13343 15h01m 06:29:22 INFO - manifests [ ] 43/13343 14h26m 06:29:22 INFO - manifests [ ] 45/13343 13h54m 06:29:22 INFO - manifests [ ] 47/13343 13h25m 06:29:22 INFO - manifests [ ] 49/13343 12h59m 06:29:22 INFO - manifests [ ] 51/13343 12h35m 06:29:22 INFO - manifests [ ] 53/13343 12h13m 06:29:22 INFO - manifests [ ] 55/13343 11h52m 06:29:22 INFO - manifests [ ] 57/13343 11h33m 06:29:22 INFO - manifests [ ] 59/13343 11h16m 06:29:22 INFO - manifests [ ] 61/13343 10h59m 06:29:22 INFO - manifests [ ] 63/13343 10h44m 06:29:22 INFO - manifests [ ] 65/13343 10h30m 06:29:22 INFO - manifests [ ] 67/13343 10h17m 06:29:22 INFO - manifests [ ] 69/13343 10h05m 06:29:22 INFO - manifests [ ] 71/13343 9h53m 06:29:22 INFO - manifests [ ] 73/13343 9h42m 06:29:22 INFO - manifests [ ] 75/13343 9h31m 06:29:22 INFO - manifests [ ] 77/13343 9h22m 06:29:22 INFO - manifests [ ] 79/13343 9h12m 06:29:22 INFO - manifests [ ] 81/13343 9h04m 06:29:22 INFO - manifests [ ] 83/13343 8h55m 06:29:22 INFO - manifests [ ] 85/13343 8h48m 06:29:22 INFO - manifests [ ] 87/13343 8h40m 06:29:22 INFO - manifests [ ] 89/13343 8h33m 06:29:22 INFO - manifests [ ] 91/13343 8h27m 06:29:22 INFO - manifests [ ] 92/13343 8h24m 06:29:22 INFO - manifests [ ] 93/13343 8h21m 06:29:22 INFO - manifests [ ] 94/13343 8h18m 06:29:22 INFO - manifests [ ] 95/13343 8h15m 06:29:22 INFO - manifests [ ] 96/13343 8h12m 06:29:22 INFO - manifests [ ] 99/13343 7h59m 06:29:22 INFO - manifests [==> ] 993/13343 44m20s 06:29:22 INFO - manifests [=======================> ] 6854/13343 3m24s 06:29:22 INFO - manifests [===================================> ] 10240/13343 1m06s 06:29:22 INFO - manifests [===========================================> ] 11833/13343 28s 06:29:22 INFO - 06:29:22 INFO - 06:29:22 INFO - files [ ] 173/54851 10m44s 06:29:22 INFO - files [ ] 218/54851 13m04s 06:29:22 INFO - files [ ] 449/54851 8m25s 06:29:22 INFO - files [ ] 544/54851 8m37s 06:29:22 INFO - files [ ] 825/54851 6m46s 06:29:22 INFO - files [ ] 906/54851 7m10s 06:29:22 INFO - files [ ] 1050/54851 7m02s 06:29:22 INFO - files [> ] 1167/54851 7m05s 06:29:22 INFO - files [> ] 1223/54851 7m29s 06:29:22 INFO - files [> ] 1437/54851 6m59s 06:29:22 INFO - files [> ] 1777/54851 6m08s 06:29:22 INFO - files [> ] 1918/54851 6m07s 06:29:22 INFO - files [> ] 2041/54851 6m12s 06:29:22 INFO - files [=> ] 2116/54851 6m23s 06:29:22 INFO - files [=> ] 2130/54851 6m47s 06:29:22 INFO - files [=> ] 2217/54851 6m54s 06:29:22 INFO - files [=> ] 2294/54851 7m03s 06:29:22 INFO - files [=> ] 2365/54851 7m13s 06:29:22 INFO - files [=> ] 2536/54851 7m03s 06:29:22 INFO - files [=> ] 2698/54851 6m57s 06:29:22 INFO - files [=> ] 2734/54851 7m11s 06:29:22 INFO - files [=> ] 2780/54851 7m23s 06:29:22 INFO - files [=> ] 2882/54851 7m24sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:29:22 INFO - (existing repository shared store: C:\builds\hg-shared\8ba995b74e18334ab3707f27e9eb8f4e37ba3d29\.hg) 06:29:22 INFO - (pulling to obtain 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd) 06:29:22 INFO - searching for changes 06:29:22 INFO - adding changesets 06:29:22 INFO - adding manifests 06:29:22 INFO - adding file changes 06:29:22 INFO - 06:29:22 INFO - 06:29:22 INFO - transaction abort! 06:29:23 INFO - rollback completed 06:29:23 INFO - stream ended unexpectedly (got 0 bytes, expected 4) 06:29:23 INFO - (retrying after network failure on attempt 2 of 3) 06:29:23 INFO - (waiting 7.19s before retry) 06:31:06 INFO - 06:31:06 INFO - searching [ <=> ] 2 06:31:06 INFO - searching [ <=> ] 3 06:31:06 INFO - searching [ <=> ] 5 06:31:06 INFO - 06:31:06 INFO - 06:31:06 INFO - changesets [ ] 1/13343 06:31:06 INFO - changesets [===============> ] 4094/13343 06:31:06 INFO - changesets [============================> ] 7306/13343 06:31:06 INFO - changesets [===================================> ] 9990/13343 02s 06:31:06 INFO - changesets [===========================================> ] 12220/13343 01s 06:31:06 INFO - 06:31:06 INFO - 06:31:06 INFO - manifests [ ] 1/13343 06:31:06 INFO - manifests [ ] 3/13343 06:31:06 INFO - manifests [ ] 5/13343 2h27m 06:31:06 INFO - manifests [ ] 7/13343 2h25m 06:31:06 INFO - manifests [ ] 9/13343 2h24m 06:31:06 INFO - manifests [ ] 11/13343 2h24m 06:31:06 INFO - manifests [ ] 13/13343 2h24m 06:31:06 INFO - manifests [ ] 15/13343 2h25m 06:31:06 INFO - manifests [ ] 17/13343 2h25m 06:31:06 INFO - manifests [ ] 19/13343 2h26m 06:31:06 INFO - manifests [ ] 21/13343 2h26m 06:31:06 INFO - manifests [ ] 25/13343 2h15m 06:31:06 INFO - manifests [ ] 31/13343 1h58m 06:31:06 INFO - manifests [ ] 36/13343 1h50m 06:31:06 INFO - manifests [ ] 38/13343 1h53m 06:31:06 INFO - manifests [ ] 41/13343 1h52m 06:31:06 INFO - manifests [ ] 43/13343 1h55m 06:31:06 INFO - manifests [ ] 45/13343 1h57m 06:31:06 INFO - manifests [ ] 47/13343 1h59m 06:31:06 INFO - manifests [ ] 49/13343 2h02m 06:31:06 INFO - manifests [ ] 51/13343 2h04m 06:31:06 INFO - manifests [ ] 53/13343 2h06m 06:31:06 INFO - manifests [ ] 55/13343 2h08m 06:31:06 INFO - manifests [ ] 57/13343 2h10m 06:31:06 INFO - manifests [ ] 59/13343 2h12m 06:31:06 INFO - manifests [ ] 61/13343 2h14m 06:31:06 INFO - manifests [ ] 63/13343 2h16m 06:31:06 INFO - manifests [ ] 65/13343 2h18m 06:31:06 INFO - manifests [ ] 67/13343 2h19m 06:31:06 INFO - manifests [ ] 69/13343 2h21m 06:31:06 INFO - manifests [ ] 71/13343 2h23m 06:31:06 INFO - manifests [ ] 73/13343 2h24m 06:31:06 INFO - manifests [ ] 75/13343 2h26m 06:31:06 INFO - manifests [ ] 77/13343 2h27m 06:31:06 INFO - manifests [ ] 79/13343 2h29m 06:31:06 INFO - manifests [ ] 81/13343 2h30m 06:31:06 INFO - manifests [ ] 83/13343 2h31m 06:31:06 INFO - manifests [ ] 85/13343 2h33m 06:31:06 INFO - manifests [ ] 87/13343 2h34m 06:31:06 INFO - manifests [ ] 89/13343 2h36m 06:31:06 INFO - manifests [ ] 90/13343 2h36m 06:31:06 INFO - manifests [ ] 91/13343 2h37m 06:31:06 INFO - manifests [ ] 92/13343 2h38m 06:31:06 INFO - manifests [ ] 93/13343 2h39m 06:31:06 INFO - manifests [ ] 94/13343 2h39m 06:31:06 INFO - manifests [ ] 95/13343 2h40m 06:31:06 INFO - manifests [ ] 96/13343 2h41m 06:31:06 INFO - manifests [ ] 99/13343 2h39m 06:31:06 INFO - manifests [==> ] 951/13343 15m29s 06:31:06 INFO - manifests [=======================> ] 6705/13343 1m12s 06:31:06 INFO - manifests [=====================================> ] 10240/13343 23sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:31:06 INFO - (existing repository shared store: C:\builds\hg-shared\8ba995b74e18334ab3707f27e9eb8f4e37ba3d29\.hg) 06:31:06 INFO - (pulling to obtain 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd) 06:31:06 INFO - searching for changes 06:31:06 INFO - adding changesets 06:31:06 INFO - adding manifests 06:31:06 INFO - 06:31:06 INFO - 06:31:06 INFO - transaction abort! 06:31:06 INFO - rollback completed 06:31:06 INFO - stream ended unexpectedly (got 138875 bytes, expected 808465717) 06:31:06 INFO - Traceback (most recent call last): 06:31:06 INFO - File "mercurial\dispatch.pyc", line 204, in _runcatch 06:31:06 INFO - File "mercurial\dispatch.pyc", line 880, in _dispatch 06:31:06 INFO - File "mercurial\dispatch.pyc", line 637, in runcommand 06:31:06 INFO - File "mercurial\extensions.pyc", line 210, in closure 06:31:06 INFO - File "hgext\color.pyc", line 503, in colorcmd 06:31:06 INFO - File "mercurial\dispatch.pyc", line 1010, in _runcommand 06:31:06 INFO - File "mercurial\dispatch.pyc", line 971, in checkargs 06:31:06 INFO - File "mercurial\dispatch.pyc", line 877, in 06:31:06 INFO - File "mercurial\util.pyc", line 1036, in check 06:31:06 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 163, in robustcheckout 06:31:06 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 289, in _docheckout 06:31:06 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 172, in callself 06:31:06 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 348, in _docheckout 06:31:06 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 172, in callself 06:31:06 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 347, in _docheckout 06:31:06 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 262, in handlepullabort 06:31:06 INFO - Abort: reached maximum number of network attempts; giving up 06:31:06 INFO - abort: reached maximum number of network attempts; giving up 06:31:07 ERROR - Return code: 255 06:31:07 INFO - rmtree: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:31:07 INFO - Using _rmtree_windows ... 06:31:07 INFO - retry: Calling _rmtree_windows with args: ('c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src',), kwargs: {}, attempt #1 06:31:07 INFO - retry: attempt #1 caught exception: repo checkout failed! 06:31:07 INFO - retry: Failed, sleeping 60 seconds before retrying 06:32:07 INFO - retry: Calling _get_revision with args: (, 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src'), kwargs: {}, attempt #2 06:32:07 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version'] 06:32:07 INFO - Copy/paste: hg --config ui.merge=internal:merge --version 06:32:07 INFO - Mercurial Distributed SCM (version 3.9.1) 06:32:07 INFO - (see https://mercurial-scm.org for more information) 06:32:07 INFO - Copyright (C) 2005-2016 Matt Mackall and others 06:32:07 INFO - This is free software; see the source for copying conditions. There is NO 06:32:07 INFO - warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. 06:32:07 INFO - Return code: 0 06:32:07 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall'] 06:32:07 INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall 06:32:07 INFO - checking encoding (cp1252)... 06:32:07 INFO - checking Python executable (c:\mozilla-build\hg\hg.exe) 06:32:07 INFO - checking Python version (2.7.12) 06:32:07 INFO - checking Python lib (c:\mozilla-build\hg\lib\library.zip)... 06:32:07 INFO - checking Mercurial version (3.9.1) 06:32:07 INFO - checking Mercurial custom build () 06:32:07 INFO - checking module policy (c) 06:32:07 INFO - checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)... 06:32:07 INFO - checking templates (c:\mozilla-build\hg\templates)... 06:32:07 INFO - checking default template (c:\mozilla-build\hg\templates\map-cmdline.default) 06:32:07 INFO - checking commit editor... (notepad) 06:32:07 INFO - checking username (Mozilla Release Engineering ) 06:32:07 INFO - no problems detected 06:32:07 INFO - Return code: 0 06:32:07 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/projects/ash', 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src', '--sharebase', 'C:/builds/hg-shared', '--revision', '2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd'] 06:32:07 INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\ash-w64-d-00000000000000000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/projects/ash c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src --sharebase C:/builds/hg-shared --revision 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd 06:33:45 INFO - 06:33:45 INFO - searching [ <=> ] 3 06:33:45 INFO - searching [ <=> ] 5 06:33:45 INFO - 06:33:45 INFO - 06:33:45 INFO - changesets [==========> ] 2956/13343 06:33:45 INFO - changesets [=========================> ] 6730/13343 06:33:45 INFO - changesets [==================================> ] 9758/13343 02s 06:33:45 INFO - changesets [===========================================> ] 12185/13343 01s 06:33:45 INFO - 06:33:45 INFO - 06:33:45 INFO - manifests [ ] 4/13343 2h30m 06:33:45 INFO - manifests [ ] 6/13343 2h27m 06:33:45 INFO - manifests [ ] 8/13343 2h25m 06:33:45 INFO - manifests [ ] 10/13343 2h25m 06:33:45 INFO - manifests [ ] 12/13343 2h25m 06:33:45 INFO - manifests [ ] 14/13343 2h26m 06:33:45 INFO - manifests [ ] 16/13343 2h26m 06:33:45 INFO - manifests [ ] 18/13343 2h27m 06:33:45 INFO - manifests [ ] 20/13343 2h28m 06:33:45 INFO - manifests [ ] 22/13343 2h28m 06:33:45 INFO - manifests [ ] 30/13343 1h58m 06:33:45 INFO - manifests [ ] 32/13343 2h01m 06:33:45 INFO - manifests [ ] 37/13343 1h53m 06:33:45 INFO - manifests [ ] 40/13343 1h53m 06:33:45 INFO - manifests [ ] 42/13343 1h55m 06:33:45 INFO - manifests [ ] 44/13343 1h57m 06:33:45 INFO - manifests [ ] 46/13343 2h00m 06:33:45 INFO - manifests [ ] 48/13343 2h02m 06:33:45 INFO - manifests [ ] 50/13343 2h05m 06:33:45 INFO - manifests [ ] 52/13343 2h07m 06:33:45 INFO - manifests [ ] 54/13343 2h09m 06:33:45 INFO - manifests [ ] 56/13343 2h11m 06:33:45 INFO - manifests [ ] 58/13343 2h13m 06:33:45 INFO - manifests [ ] 60/13343 2h15m 06:33:45 INFO - manifests [ ] 62/13343 2h17m 06:33:45 INFO - manifests [ ] 64/13343 2h19m 06:33:45 INFO - manifests [ ] 66/13343 2h20m 06:33:45 INFO - manifests [ ] 68/13343 2h22m 06:33:45 INFO - manifests [ ] 70/13343 2h24m 06:33:45 INFO - manifests [ ] 72/13343 2h25m 06:33:45 INFO - manifests [ ] 74/13343 2h27m 06:33:45 INFO - manifests [ ] 76/13343 2h28m 06:33:45 INFO - manifests [ ] 78/13343 2h30m 06:33:45 INFO - manifests [ ] 80/13343 2h31m 06:33:45 INFO - manifests [ ] 82/13343 2h32m 06:33:45 INFO - manifests [ ] 84/13343 2h34m 06:33:45 INFO - manifests [ ] 86/13343 2h35m 06:33:45 INFO - manifests [ ] 88/13343 2h37m 06:33:45 INFO - manifests [ ] 90/13343 2h38m 06:33:45 INFO - manifests [ ] 92/13343 2h39m 06:33:45 INFO - manifests [ ] 93/13343 2h40m 06:33:45 INFO - manifests [ ] 94/13343 2h41m 06:33:45 INFO - manifests [ ] 95/13343 2h41m 06:33:45 INFO - manifests [ ] 96/13343 2h42m 06:33:45 INFO - manifests [ ] 99/13343 2h40m 06:33:45 INFO - manifests [==> ] 995/13343 14m50s 06:33:45 INFO - manifests [=========================> ] 7239/13343 1m02s 06:33:45 INFO - manifests [=====================================> ] 10240/13343 23s 06:33:45 INFO - manifests [===========================================> ] 11833/13343 10sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:33:45 INFO - (sharing from existing pooled repository 8ba995b74e18334ab3707f27e9eb8f4e37ba3d29) 06:33:45 INFO - searching for changes 06:33:45 INFO - adding changesets 06:33:45 INFO - adding manifests 06:33:45 INFO - 06:33:45 INFO - 06:33:45 INFO - transaction abort! 06:33:45 INFO - rollback completed 06:33:45 INFO - stream ended unexpectedly (got 8648 bytes, expected 1785933683) 06:33:45 INFO - (retrying after network failure on attempt 1 of 3) 06:33:45 INFO - (waiting 3.76s before retry) 06:36:03 INFO - 06:36:03 INFO - searching [ <=> ] 2 06:36:03 INFO - searching [ <=> ] 3 06:36:03 INFO - searching [ <=> ] 5 06:36:03 INFO - 06:36:03 INFO - 06:36:03 INFO - changesets [ ] 1/13343 06:36:03 INFO - changesets [===============> ] 4034/13343 06:36:03 INFO - changesets [===========================> ] 7296/13343 06:36:03 INFO - changesets [===================================> ] 9990/13343 02s 06:36:03 INFO - changesets [===========================================> ] 12197/13343 01s 06:36:03 INFO - 06:36:03 INFO - 06:36:03 INFO - manifests [ ] 1/13343 06:36:03 INFO - manifests [ ] 3/13343 10d19h 06:36:03 INFO - manifests [ ] 5/13343 5d11h 06:36:03 INFO - manifests [ ] 7/13343 3d16h 06:36:03 INFO - manifests [ ] 9/13343 2d19h 06:36:03 INFO - manifests [ ] 11/13343 2d06h 06:36:03 INFO - manifests [ ] 13/13343 1d21h 06:36:03 INFO - manifests [ ] 15/13343 1d15h 06:36:03 INFO - manifests [ ] 17/13343 1d11h 06:36:03 INFO - manifests [ ] 19/13343 1d07h 06:36:03 INFO - manifests [ ] 21/13343 27h58m 06:36:03 INFO - manifests [ ] 25/13343 23h31m 06:36:03 INFO - manifests [ ] 31/13343 18h59m 06:36:03 INFO - manifests [ ] 36/13343 16h25m 06:36:03 INFO - manifests [ ] 38/13343 15h40m 06:36:03 INFO - manifests [ ] 41/13343 14h38m 06:36:03 INFO - manifests [ ] 43/13343 14h04m 06:36:03 INFO - manifests [ ] 45/13343 13h33m 06:36:03 INFO - manifests [ ] 47/13343 13h05m 06:36:03 INFO - manifests [ ] 49/13343 12h40m 06:36:03 INFO - manifests [ ] 51/13343 12h16m 06:36:03 INFO - manifests [ ] 53/13343 11h55m 06:36:03 INFO - manifests [ ] 55/13343 11h35m 06:36:03 INFO - manifests [ ] 57/13343 11h17m 06:36:03 INFO - manifests [ ] 59/13343 11h00m 06:36:03 INFO - manifests [ ] 61/13343 10h44m 06:36:03 INFO - manifests [ ] 63/13343 10h29m 06:36:03 INFO - manifests [ ] 65/13343 10h16m 06:36:03 INFO - manifests [ ] 67/13343 10h03m 06:36:03 INFO - manifests [ ] 69/13343 9h51m 06:36:03 INFO - manifests [ ] 71/13343 9h40m 06:36:03 INFO - manifests [ ] 73/13343 9h29m 06:36:03 INFO - manifests [ ] 75/13343 9h19m 06:36:03 INFO - manifests [ ] 77/13343 9h10m 06:36:03 INFO - manifests [ ] 79/13343 9h01m 06:36:03 INFO - manifests [ ] 81/13343 8h52m 06:36:03 INFO - manifests [ ] 83/13343 8h44m 06:36:03 INFO - manifests [ ] 85/13343 8h37m 06:36:03 INFO - manifests [ ] 87/13343 8h30m 06:36:03 INFO - manifests [ ] 89/13343 8h23m 06:36:03 INFO - manifests [ ] 91/13343 8h17m 06:36:03 INFO - manifests [ ] 92/13343 8h14m 06:36:03 INFO - manifests [ ] 93/13343 8h11m 06:36:03 INFO - manifests [ ] 94/13343 8h08m 06:36:03 INFO - manifests [ ] 95/13343 8h05m 06:36:03 INFO - manifests [ ] 96/13343 8h02m 06:36:03 INFO - manifests [ ] 99/13343 7h50m 06:36:03 INFO - manifests [==> ] 992/13343 43m31s 06:36:03 INFO - manifests [=======================> ] 6761/13343 3m25s 06:36:03 INFO - manifests [===================================> ] 10240/13343 1m05s 06:36:03 INFO - manifests [===========================================> ] 11833/13343 28sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:36:03 INFO - (existing repository shared store: C:\builds\hg-shared\8ba995b74e18334ab3707f27e9eb8f4e37ba3d29\.hg) 06:36:03 INFO - (pulling to obtain 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd) 06:36:03 INFO - searching for changes 06:36:03 INFO - adding changesets 06:36:03 INFO - adding manifests 06:36:03 INFO - 06:36:03 INFO - 06:36:03 INFO - transaction abort! 06:36:03 INFO - rollback completed 06:36:03 INFO - stream ended unexpectedly (got 0 bytes, expected 4) 06:36:03 INFO - (retrying after network failure on attempt 2 of 3) 06:36:03 INFO - (waiting 7.21s before retry) 06:37:51 INFO - 06:37:51 INFO - searching [ <=> ] 2 06:37:51 INFO - searching [ <=> ] 3 06:37:51 INFO - searching [ <=> ] 5 06:37:51 INFO - 06:37:51 INFO - 06:37:51 INFO - changesets [ ] 1/13343 06:37:51 INFO - changesets [==============> ] 3882/13343 06:37:51 INFO - changesets [==========================> ] 7017/13343 06:37:51 INFO - changesets [==================================> ] 9675/13343 02s 06:37:51 INFO - changesets [==========================================> ] 11844/13343 01s 06:37:51 INFO - 06:37:51 INFO - 06:37:51 INFO - manifests [ ] 1/13343 06:37:51 INFO - manifests [ ] 3/13343 2w05d 06:37:51 INFO - manifests [ ] 5/13343 9d12h 06:37:51 INFO - manifests [ ] 7/13343 6d09h 06:37:51 INFO - manifests [ ] 9/13343 4d20h 06:37:51 INFO - manifests [ ] 11/13343 3d21h 06:37:51 INFO - manifests [ ] 13/13343 3d06h 06:37:51 INFO - manifests [ ] 15/13343 2d19h 06:37:51 INFO - manifests [ ] 17/13343 2d11h 06:37:51 INFO - manifests [ ] 19/13343 2d05h 06:37:51 INFO - manifests [ ] 21/13343 2d00h 06:37:51 INFO - manifests [ ] 25/13343 1d16h 06:37:51 INFO - manifests [ ] 31/13343 1d08h 06:37:51 INFO - manifests [ ] 36/13343 27h33m 06:37:51 INFO - manifests [ ] 38/13343 26h12m 06:37:51 INFO - manifests [ ] 41/13343 24h22m 06:37:51 INFO - manifests [ ] 43/13343 23h20m 06:37:51 INFO - manifests [ ] 45/13343 22h24m 06:37:51 INFO - manifests [ ] 47/13343 21h33m 06:37:51 INFO - manifests [ ] 49/13343 20h46m 06:37:51 INFO - manifests [ ] 51/13343 20h03m 06:37:51 INFO - manifests [ ] 53/13343 19h24m 06:37:51 INFO - manifests [ ] 55/13343 18h48m 06:37:51 INFO - manifests [ ] 57/13343 18h14m 06:37:51 INFO - manifests [ ] 59/13343 17h43m 06:37:51 INFO - manifests [ ] 61/13343 17h14m 06:37:51 INFO - manifests [ ] 63/13343 16h47m 06:37:51 INFO - manifests [ ] 65/13343 16h21m 06:37:51 INFO - manifests [ ] 67/13343 15h58m 06:37:51 INFO - manifests [ ] 69/13343 15h35m 06:37:51 INFO - manifests [ ] 71/13343 15h14m 06:37:51 INFO - manifests [ ] 73/13343 14h54m 06:37:51 INFO - manifests [ ] 75/13343 14h36m 06:37:51 INFO - manifests [ ] 77/13343 14h18m 06:37:51 INFO - manifests [ ] 79/13343 14h01m 06:37:51 INFO - manifests [ ] 81/13343 13h45m 06:37:51 INFO - manifests [ ] 83/13343 13h30m 06:37:51 INFO - manifests [ ] 85/13343 13h16m 06:37:51 INFO - manifests [ ] 87/13343 13h02m 06:37:51 INFO - manifests [ ] 89/13343 12h49m 06:37:51 INFO - manifests [ ] 91/13343 12h37m 06:37:51 INFO - manifests [ ] 92/13343 12h31m 06:37:51 INFO - manifests [ ] 93/13343 12h25m 06:37:51 INFO - manifests [ ] 94/13343 12h19m 06:37:51 INFO - manifests [ ] 95/13343 12h14m 06:37:51 INFO - manifests [ ] 96/13343 12h08m 06:37:51 INFO - manifests [ ] 99/13343 11h49m 06:37:51 INFO - manifests [==> ] 986/13343 1h06m 06:37:51 INFO - manifests [======================> ] 6615/13343 5m22s 06:37:51 INFO - manifests [===================================> ] 10240/13343 1m37s 06:37:51 INFO - manifests [===========================================> ] 11821/13343 42sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:37:51 INFO - (existing repository shared store: C:\builds\hg-shared\8ba995b74e18334ab3707f27e9eb8f4e37ba3d29\.hg) 06:37:51 INFO - (pulling to obtain 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd) 06:37:51 INFO - searching for changes 06:37:51 INFO - adding changesets 06:37:51 INFO - adding manifests 06:37:51 INFO - 06:37:51 INFO - 06:37:51 INFO - transaction abort! 06:37:51 INFO - rollback completed 06:37:51 INFO - stream ended unexpectedly (got 0 bytes, expected 4) 06:37:51 INFO - Traceback (most recent call last): 06:37:51 INFO - File "mercurial\dispatch.pyc", line 204, in _runcatch 06:37:51 INFO - File "mercurial\dispatch.pyc", line 880, in _dispatch 06:37:51 INFO - File "mercurial\dispatch.pyc", line 637, in runcommand 06:37:51 INFO - File "mercurial\extensions.pyc", line 210, in closure 06:37:51 INFO - File "hgext\color.pyc", line 503, in colorcmd 06:37:51 INFO - File "mercurial\dispatch.pyc", line 1010, in _runcommand 06:37:51 INFO - File "mercurial\dispatch.pyc", line 971, in checkargs 06:37:51 INFO - File "mercurial\dispatch.pyc", line 877, in 06:37:51 INFO - File "mercurial\util.pyc", line 1036, in check 06:37:51 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 163, in robustcheckout 06:37:51 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 289, in _docheckout 06:37:51 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 172, in callself 06:37:51 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 348, in _docheckout 06:37:51 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 172, in callself 06:37:51 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 347, in _docheckout 06:37:51 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 262, in handlepullabort 06:37:51 INFO - Abort: reached maximum number of network attempts; giving up 06:37:51 INFO - abort: reached maximum number of network attempts; giving up 06:37:52 ERROR - Return code: 255 06:37:52 INFO - rmtree: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:37:52 INFO - Using _rmtree_windows ... 06:37:52 INFO - retry: Calling _rmtree_windows with args: ('c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src',), kwargs: {}, attempt #1 06:37:52 INFO - retry: attempt #2 caught exception: repo checkout failed! 06:37:52 INFO - retry: Failed, sleeping 120 seconds before retrying 06:39:52 INFO - retry: Calling _get_revision with args: (, 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src'), kwargs: {}, attempt #3 06:39:52 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version'] 06:39:52 INFO - Copy/paste: hg --config ui.merge=internal:merge --version 06:39:52 INFO - Mercurial Distributed SCM (version 3.9.1) 06:39:52 INFO - (see https://mercurial-scm.org for more information) 06:39:52 INFO - Copyright (C) 2005-2016 Matt Mackall and others 06:39:52 INFO - This is free software; see the source for copying conditions. There is NO 06:39:52 INFO - warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. 06:39:52 INFO - Return code: 0 06:39:52 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall'] 06:39:52 INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall 06:39:52 INFO - checking encoding (cp1252)... 06:39:52 INFO - checking Python executable (c:\mozilla-build\hg\hg.exe) 06:39:52 INFO - checking Python version (2.7.12) 06:39:52 INFO - checking Python lib (c:\mozilla-build\hg\lib\library.zip)... 06:39:52 INFO - checking Mercurial version (3.9.1) 06:39:52 INFO - checking Mercurial custom build () 06:39:52 INFO - checking module policy (c) 06:39:52 INFO - checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)... 06:39:52 INFO - checking templates (c:\mozilla-build\hg\templates)... 06:39:52 INFO - checking default template (c:\mozilla-build\hg\templates\map-cmdline.default) 06:39:52 INFO - checking commit editor... (notepad) 06:39:52 INFO - checking username (Mozilla Release Engineering ) 06:39:52 INFO - no problems detected 06:39:52 INFO - Return code: 0 06:39:52 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/projects/ash', 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src', '--sharebase', 'C:/builds/hg-shared', '--revision', '2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd'] 06:39:52 INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\ash-w64-d-00000000000000000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/projects/ash c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src --sharebase C:/builds/hg-shared --revision 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd 06:41:30 INFO - 06:41:30 INFO - searching [ <=> ] 3 06:41:30 INFO - searching [ <=> ] 5 06:41:30 INFO - 06:41:30 INFO - 06:41:30 INFO - changesets [==================> ] 4931/13343 06:41:30 INFO - changesets [=============================> ] 8321/13343 02s 06:41:30 INFO - changesets [=======================================> ] 11128/13343 01s 06:41:30 INFO - 06:41:30 INFO - 06:41:30 INFO - manifests [ ] 4/13343 2h31m 06:41:30 INFO - manifests [ ] 6/13343 2h27m 06:41:30 INFO - manifests [ ] 8/13343 2h26m 06:41:30 INFO - manifests [ ] 10/13343 2h26m 06:41:30 INFO - manifests [ ] 12/13343 2h26m 06:41:30 INFO - manifests [ ] 14/13343 2h26m 06:41:30 INFO - manifests [ ] 16/13343 2h27m 06:41:30 INFO - manifests [ ] 18/13343 2h28m 06:41:30 INFO - manifests [ ] 20/13343 2h29m 06:41:30 INFO - manifests [ ] 22/13343 2h29m 06:41:30 INFO - manifests [ ] 30/13343 1h59m 06:41:30 INFO - manifests [ ] 32/13343 2h02m 06:41:30 INFO - manifests [ ] 37/13343 1h54m 06:41:30 INFO - manifests [ ] 40/13343 1h53m 06:41:30 INFO - manifests [ ] 42/13343 1h56m 06:41:30 INFO - manifests [ ] 44/13343 1h58m 06:41:30 INFO - manifests [ ] 46/13343 2h00m 06:41:30 INFO - manifests [ ] 48/13343 2h03m 06:41:30 INFO - manifests [ ] 50/13343 2h05m 06:41:30 INFO - manifests [ ] 52/13343 2h07m 06:41:30 INFO - manifests [ ] 54/13343 2h09m 06:41:30 INFO - manifests [ ] 56/13343 2h12m 06:41:30 INFO - manifests [ ] 58/13343 2h14m 06:41:30 INFO - manifests [ ] 60/13343 2h15m 06:41:30 INFO - manifests [ ] 62/13343 2h17m 06:41:30 INFO - manifests [ ] 64/13343 2h19m 06:41:30 INFO - manifests [ ] 66/13343 2h21m 06:41:30 INFO - manifests [ ] 68/13343 2h23m 06:41:30 INFO - manifests [ ] 70/13343 2h24m 06:41:30 INFO - manifests [ ] 72/13343 2h26m 06:41:30 INFO - manifests [ ] 74/13343 2h27m 06:41:30 INFO - manifests [ ] 76/13343 2h29m 06:41:30 INFO - manifests [ ] 78/13343 2h30m 06:41:30 INFO - manifests [ ] 80/13343 2h32m 06:41:30 INFO - manifests [ ] 82/13343 2h33m 06:41:30 INFO - manifests [ ] 84/13343 2h34m 06:41:30 INFO - manifests [ ] 86/13343 2h36m 06:41:30 INFO - manifests [ ] 88/13343 2h37m 06:41:30 INFO - manifests [ ] 90/13343 2h39m 06:41:30 INFO - manifests [ ] 92/13343 2h40m 06:41:30 INFO - manifests [ ] 93/13343 2h41m 06:41:30 INFO - manifests [ ] 94/13343 2h41m 06:41:30 INFO - manifests [ ] 95/13343 2h42m 06:41:30 INFO - manifests [ ] 96/13343 2h43m 06:41:30 INFO - manifests [ ] 99/13343 2h40m 06:41:30 INFO - manifests [==> ] 993/13343 14m56s 06:41:30 INFO - manifests [=========================> ] 7266/13343 1m01s 06:41:30 INFO - manifests [=====================================> ] 10240/13343 23sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:41:30 INFO - (sharing from existing pooled repository 8ba995b74e18334ab3707f27e9eb8f4e37ba3d29) 06:41:30 INFO - searching for changes 06:41:30 INFO - adding changesets 06:41:30 INFO - adding manifests 06:41:30 INFO - 06:41:30 INFO - 06:41:30 INFO - transaction abort! 06:41:30 INFO - rollback completed 06:41:30 INFO - stream ended unexpectedly (got 5614 bytes, expected 1886545267) 06:41:30 INFO - (retrying after network failure on attempt 1 of 3) 06:41:30 INFO - (waiting 6.44s before retry) 06:43:51 INFO - 06:43:51 INFO - searching [ <=> ] 2 06:43:51 INFO - searching [ <=> ] 3 06:43:51 INFO - searching [ <=> ] 5 06:43:51 INFO - 06:43:51 INFO - 06:43:51 INFO - changesets [ ] 1/13343 06:43:51 INFO - changesets [==============> ] 3939/13343 06:43:51 INFO - changesets [===========================> ] 7227/13343 06:43:51 INFO - changesets [===================================> ] 9969/13343 02s 06:43:51 INFO - changesets [===========================================> ] 12218/13343 01s 06:43:51 INFO - 06:43:51 INFO - 06:43:51 INFO - manifests [ ] 1/13343 06:43:51 INFO - manifests [ ] 3/13343 11d00h 06:43:51 INFO - manifests [ ] 5/13343 5d14h 06:43:51 INFO - manifests [ ] 7/13343 3d18h 06:43:51 INFO - manifests [ ] 9/13343 2d20h 06:43:51 INFO - manifests [ ] 11/13343 2d07h 06:43:51 INFO - manifests [ ] 13/13343 1d22h 06:43:51 INFO - manifests [ ] 15/13343 1d16h 06:43:51 INFO - manifests [ ] 17/13343 1d12h 06:43:51 INFO - manifests [ ] 19/13343 1d08h 06:43:51 INFO - manifests [ ] 21/13343 28h33m 06:43:51 INFO - manifests [ ] 25/13343 24h00m 06:43:51 INFO - manifests [ ] 31/13343 19h22m 06:43:51 INFO - manifests [ ] 36/13343 16h45m 06:43:51 INFO - manifests [ ] 38/13343 15h59m 06:43:51 INFO - manifests [ ] 41/13343 14h55m 06:43:51 INFO - manifests [ ] 43/13343 14h20m 06:43:51 INFO - manifests [ ] 45/13343 13h48m 06:43:51 INFO - manifests [ ] 47/13343 13h20m 06:43:51 INFO - manifests [ ] 49/13343 12h54m 06:43:51 INFO - manifests [ ] 51/13343 12h30m 06:43:51 INFO - manifests [ ] 53/13343 12h08m 06:43:51 INFO - manifests [ ] 55/13343 11h48m 06:43:51 INFO - manifests [ ] 57/13343 11h29m 06:43:51 INFO - manifests [ ] 59/13343 11h12m 06:43:51 INFO - manifests [ ] 61/13343 10h56m 06:43:51 INFO - manifests [ ] 63/13343 10h41m 06:43:51 INFO - manifests [ ] 65/13343 10h27m 06:43:51 INFO - manifests [ ] 67/13343 10h14m 06:43:51 INFO - manifests [ ] 69/13343 10h01m 06:43:51 INFO - manifests [ ] 71/13343 9h50m 06:43:51 INFO - manifests [ ] 73/13343 9h39m 06:43:51 INFO - manifests [ ] 75/13343 9h29m 06:43:51 INFO - manifests [ ] 77/13343 9h19m 06:43:51 INFO - manifests [ ] 79/13343 9h10m 06:43:51 INFO - manifests [ ] 81/13343 9h01m 06:43:51 INFO - manifests [ ] 83/13343 8h53m 06:43:51 INFO - manifests [ ] 85/13343 8h46m 06:43:51 INFO - manifests [ ] 87/13343 8h38m 06:43:51 INFO - manifests [ ] 89/13343 8h31m 06:43:51 INFO - manifests [ ] 90/13343 8h28m 06:43:51 INFO - manifests [ ] 91/13343 8h25m 06:43:51 INFO - manifests [ ] 92/13343 8h22m 06:43:51 INFO - manifests [ ] 93/13343 8h19m 06:43:51 INFO - manifests [ ] 94/13343 8h16m 06:43:51 INFO - manifests [ ] 95/13343 8h13m 06:43:51 INFO - manifests [ ] 96/13343 8h10m 06:43:51 INFO - manifests [ ] 99/13343 7h58m 06:43:51 INFO - manifests [==> ] 990/13343 44m19s 06:43:51 INFO - manifests [=======================> ] 6839/13343 3m24s 06:43:51 INFO - manifests [===================================> ] 10240/13343 1m06sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:43:51 INFO - (existing repository shared store: C:\builds\hg-shared\8ba995b74e18334ab3707f27e9eb8f4e37ba3d29\.hg) 06:43:51 INFO - (pulling to obtain 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd) 06:43:51 INFO - searching for changes 06:43:51 INFO - adding changesets 06:43:51 INFO - adding manifests 06:43:51 INFO - 06:43:51 INFO - 06:43:51 INFO - transaction abort! 06:43:51 INFO - rollback completed 06:43:51 INFO - stream ended unexpectedly (got 245016 bytes, expected 909326434) 06:43:51 INFO - (retrying after network failure on attempt 2 of 3) 06:43:51 INFO - (waiting 6.80s before retry) 06:45:39 INFO - 06:45:39 INFO - searching [ <=> ] 2 06:45:39 INFO - searching [ <=> ] 3 06:45:39 INFO - searching [ <=> ] 5 06:45:39 INFO - 06:45:39 INFO - 06:45:39 INFO - changesets [ ] 1/13343 06:45:39 INFO - changesets [==============> ] 3824/13343 06:45:39 INFO - changesets [==========================> ] 6987/13343 06:45:39 INFO - changesets [==================================> ] 9684/13343 02s 06:45:39 INFO - changesets [==========================================> ] 11903/13343 01s 06:45:39 INFO - 06:45:39 INFO - 06:45:39 INFO - manifests [ ] 1/13343 06:45:39 INFO - manifests [ ] 3/13343 2w06d 06:45:39 INFO - manifests [ ] 5/13343 9d16h 06:45:39 INFO - manifests [ ] 7/13343 6d11h 06:45:39 INFO - manifests [ ] 9/13343 4d21h 06:45:39 INFO - manifests [ ] 11/13343 3d22h 06:45:39 INFO - manifests [ ] 13/13343 3d07h 06:45:39 INFO - manifests [ ] 15/13343 2d20h 06:45:39 INFO - manifests [ ] 17/13343 2d12h 06:45:39 INFO - manifests [ ] 19/13343 2d06h 06:45:39 INFO - manifests [ ] 21/13343 2d01h 06:45:39 INFO - manifests [ ] 25/13343 1d17h 06:45:39 INFO - manifests [ ] 31/13343 1d09h 06:45:39 INFO - manifests [ ] 36/13343 27h57m 06:45:39 INFO - manifests [ ] 38/13343 26h35m 06:45:39 INFO - manifests [ ] 41/13343 24h43m 06:45:39 INFO - manifests [ ] 43/13343 23h40m 06:45:39 INFO - manifests [ ] 45/13343 22h43m 06:45:39 INFO - manifests [ ] 47/13343 21h51m 06:45:39 INFO - manifests [ ] 49/13343 21h04m 06:45:39 INFO - manifests [ ] 51/13343 20h21m 06:45:39 INFO - manifests [ ] 53/13343 19h40m 06:45:39 INFO - manifests [ ] 55/13343 19h03m 06:45:39 INFO - manifests [ ] 57/13343 18h29m 06:45:39 INFO - manifests [ ] 59/13343 17h57m 06:45:39 INFO - manifests [ ] 61/13343 17h27m 06:45:39 INFO - manifests [ ] 63/13343 17h00m 06:45:39 INFO - manifests [ ] 65/13343 16h34m 06:45:39 INFO - manifests [ ] 67/13343 16h10m 06:45:39 INFO - manifests [ ] 69/13343 15h47m 06:45:39 INFO - manifests [ ] 71/13343 15h25m 06:45:39 INFO - manifests [ ] 73/13343 15h05m 06:45:39 INFO - manifests [ ] 75/13343 14h46m 06:45:39 INFO - manifests [ ] 77/13343 14h28m 06:45:39 INFO - manifests [ ] 79/13343 14h11m 06:45:39 INFO - manifests [ ] 81/13343 13h54m 06:45:39 INFO - manifests [ ] 83/13343 13h39m 06:45:39 INFO - manifests [ ] 85/13343 13h25m 06:45:39 INFO - manifests [ ] 87/13343 13h11m 06:45:39 INFO - manifests [ ] 89/13343 12h58m 06:45:39 INFO - manifests [ ] 91/13343 12h45m 06:45:39 INFO - manifests [ ] 92/13343 12h39m 06:45:39 INFO - manifests [ ] 93/13343 12h33m 06:45:39 INFO - manifests [ ] 94/13343 12h27m 06:45:39 INFO - manifests [ ] 95/13343 12h22m 06:45:39 INFO - manifests [ ] 96/13343 12h16m 06:45:39 INFO - manifests [ ] 99/13343 11h56m 06:45:39 INFO - manifests [==> ] 977/13343 1h08m 06:45:39 INFO - manifests [=======================> ] 6763/13343 5m12s 06:45:39 INFO - manifests [===================================> ] 10240/13343 1m38s 06:45:39 INFO - manifests [===========================================> ] 11823/13343 42sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:45:39 INFO - (existing repository shared store: C:\builds\hg-shared\8ba995b74e18334ab3707f27e9eb8f4e37ba3d29\.hg) 06:45:39 INFO - (pulling to obtain 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd) 06:45:39 INFO - searching for changes 06:45:39 INFO - adding changesets 06:45:39 INFO - adding manifests 06:45:39 INFO - 06:45:39 INFO - 06:45:39 INFO - transaction abort! 06:45:39 INFO - rollback completed 06:45:39 INFO - stream ended unexpectedly (got 260694 bytes, expected 1698194743) 06:45:39 INFO - Traceback (most recent call last): 06:45:39 INFO - File "mercurial\dispatch.pyc", line 204, in _runcatch 06:45:39 INFO - File "mercurial\dispatch.pyc", line 880, in _dispatch 06:45:39 INFO - File "mercurial\dispatch.pyc", line 637, in runcommand 06:45:39 INFO - File "mercurial\extensions.pyc", line 210, in closure 06:45:39 INFO - File "hgext\color.pyc", line 503, in colorcmd 06:45:39 INFO - File "mercurial\dispatch.pyc", line 1010, in _runcommand 06:45:39 INFO - File "mercurial\dispatch.pyc", line 971, in checkargs 06:45:39 INFO - File "mercurial\dispatch.pyc", line 877, in 06:45:39 INFO - File "mercurial\util.pyc", line 1036, in check 06:45:39 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 163, in robustcheckout 06:45:39 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 289, in _docheckout 06:45:39 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 172, in callself 06:45:39 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 348, in _docheckout 06:45:39 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 172, in callself 06:45:39 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 347, in _docheckout 06:45:39 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 262, in handlepullabort 06:45:39 INFO - Abort: reached maximum number of network attempts; giving up 06:45:39 INFO - abort: reached maximum number of network attempts; giving up 06:45:40 ERROR - Return code: 255 06:45:40 INFO - rmtree: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:45:40 INFO - Using _rmtree_windows ... 06:45:40 INFO - retry: Calling _rmtree_windows with args: ('c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src',), kwargs: {}, attempt #1 06:45:40 INFO - retry: attempt #3 caught exception: repo checkout failed! 06:45:40 INFO - retry: Failed, sleeping 240 seconds before retrying 06:49:40 INFO - retry: Calling _get_revision with args: (, 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src'), kwargs: {}, attempt #4 06:49:40 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version'] 06:49:40 INFO - Copy/paste: hg --config ui.merge=internal:merge --version 06:49:40 INFO - Mercurial Distributed SCM (version 3.9.1) 06:49:40 INFO - (see https://mercurial-scm.org for more information) 06:49:40 INFO - Copyright (C) 2005-2016 Matt Mackall and others 06:49:40 INFO - This is free software; see the source for copying conditions. There is NO 06:49:40 INFO - warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. 06:49:40 INFO - Return code: 0 06:49:40 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall'] 06:49:40 INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall 06:49:40 INFO - checking encoding (cp1252)... 06:49:40 INFO - checking Python executable (c:\mozilla-build\hg\hg.exe) 06:49:40 INFO - checking Python version (2.7.12) 06:49:40 INFO - checking Python lib (c:\mozilla-build\hg\lib\library.zip)... 06:49:40 INFO - checking Mercurial version (3.9.1) 06:49:40 INFO - checking Mercurial custom build () 06:49:40 INFO - checking module policy (c) 06:49:40 INFO - checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)... 06:49:40 INFO - checking templates (c:\mozilla-build\hg\templates)... 06:49:40 INFO - checking default template (c:\mozilla-build\hg\templates\map-cmdline.default) 06:49:40 INFO - checking commit editor... (notepad) 06:49:40 INFO - checking username (Mozilla Release Engineering ) 06:49:40 INFO - no problems detected 06:49:40 INFO - Return code: 0 06:49:40 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/projects/ash', 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src', '--sharebase', 'C:/builds/hg-shared', '--revision', '2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd'] 06:49:40 INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\ash-w64-d-00000000000000000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/projects/ash c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src --sharebase C:/builds/hg-shared --revision 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd 06:51:18 INFO - 06:51:18 INFO - searching [ <=> ] 3 06:51:18 INFO - searching [ <=> ] 5 06:51:18 INFO - 06:51:18 INFO - 06:51:18 INFO - changesets [====================> ] 5380/13343 06:51:18 INFO - changesets [==============================> ] 8657/13343 02s 06:51:18 INFO - changesets [========================================> ] 11400/13343 01s 06:51:18 INFO - 06:51:18 INFO - 06:51:18 INFO - manifests [ ] 4/13343 2h31m 06:51:18 INFO - manifests [ ] 6/13343 2h28m 06:51:18 INFO - manifests [ ] 8/13343 2h27m 06:51:18 INFO - manifests [ ] 10/13343 2h26m 06:51:18 INFO - manifests [ ] 12/13343 2h26m 06:51:18 INFO - manifests [ ] 14/13343 2h27m 06:51:18 INFO - manifests [ ] 16/13343 2h28m 06:51:18 INFO - manifests [ ] 18/13343 2h28m 06:51:18 INFO - manifests [ ] 20/13343 2h29m 06:51:18 INFO - manifests [ ] 22/13343 2h30m 06:51:18 INFO - manifests [ ] 30/13343 1h59m 06:51:18 INFO - manifests [ ] 32/13343 2h02m 06:51:18 INFO - manifests [ ] 37/13343 1h54m 06:51:18 INFO - manifests [ ] 40/13343 1h54m 06:51:18 INFO - manifests [ ] 42/13343 1h56m 06:51:18 INFO - manifests [ ] 44/13343 1h58m 06:51:18 INFO - manifests [ ] 46/13343 2h01m 06:51:18 INFO - manifests [ ] 48/13343 2h03m 06:51:18 INFO - manifests [ ] 50/13343 2h06m 06:51:18 INFO - manifests [ ] 52/13343 2h08m 06:51:18 INFO - manifests [ ] 54/13343 2h10m 06:51:18 INFO - manifests [ ] 56/13343 2h12m 06:51:18 INFO - manifests [ ] 58/13343 2h14m 06:51:18 INFO - manifests [ ] 60/13343 2h16m 06:51:18 INFO - manifests [ ] 62/13343 2h18m 06:51:18 INFO - manifests [ ] 64/13343 2h20m 06:51:18 INFO - manifests [ ] 66/13343 2h21m 06:51:18 INFO - manifests [ ] 68/13343 2h23m 06:51:18 INFO - manifests [ ] 70/13343 2h25m 06:51:18 INFO - manifests [ ] 72/13343 2h26m 06:51:18 INFO - manifests [ ] 74/13343 2h28m 06:51:18 INFO - manifests [ ] 76/13343 2h29m 06:51:18 INFO - manifests [ ] 78/13343 2h31m 06:51:18 INFO - manifests [ ] 80/13343 2h32m 06:51:18 INFO - manifests [ ] 82/13343 2h33m 06:51:18 INFO - manifests [ ] 84/13343 2h35m 06:51:18 INFO - manifests [ ] 86/13343 2h36m 06:51:18 INFO - manifests [ ] 88/13343 2h38m 06:51:18 INFO - manifests [ ] 90/13343 2h39m 06:51:18 INFO - manifests [ ] 92/13343 2h40m 06:51:18 INFO - manifests [ ] 93/13343 2h41m 06:51:18 INFO - manifests [ ] 94/13343 2h42m 06:51:18 INFO - manifests [ ] 95/13343 2h42m 06:51:18 INFO - manifests [ ] 96/13343 2h43m 06:51:18 INFO - manifests [ ] 99/13343 2h41m 06:51:18 INFO - manifests [==> ] 993/13343 14m58s 06:51:18 INFO - manifests [=========================> ] 7275/13343 1m01s 06:51:18 INFO - manifests [=====================================> ] 10240/13343 23sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:51:18 INFO - (sharing from existing pooled repository 8ba995b74e18334ab3707f27e9eb8f4e37ba3d29) 06:51:18 INFO - searching for changes 06:51:18 INFO - adding changesets 06:51:18 INFO - adding manifests 06:51:18 INFO - 06:51:18 INFO - 06:51:18 INFO - transaction abort! 06:51:18 INFO - rollback completed 06:51:18 INFO - stream ended unexpectedly (got 0 bytes, expected 4) 06:51:18 INFO - (retrying after network failure on attempt 1 of 3) 06:51:18 INFO - (waiting 4.07s before retry) 06:53:38 INFO - 06:53:38 INFO - searching [ <=> ] 2 06:53:38 INFO - searching [ <=> ] 3 06:53:38 INFO - searching [ <=> ] 5 06:53:38 INFO - 06:53:38 INFO - 06:53:38 INFO - changesets [ ] 1/13343 06:53:38 INFO - changesets [===============> ] 4053/13343 06:53:38 INFO - changesets [============================> ] 7301/13343 06:53:38 INFO - changesets [===================================> ] 10000/13343 02s 06:53:38 INFO - changesets [===========================================> ] 12239/13343 01s 06:53:38 INFO - 06:53:38 INFO - 06:53:38 INFO - manifests [ ] 1/13343 06:53:38 INFO - manifests [ ] 3/13343 10d21h 06:53:38 INFO - manifests [ ] 5/13343 5d12h 06:53:38 INFO - manifests [ ] 7/13343 3d17h 06:53:38 INFO - manifests [ ] 9/13343 2d19h 06:53:38 INFO - manifests [ ] 11/13343 2d07h 06:53:38 INFO - manifests [ ] 13/13343 1d22h 06:53:38 INFO - manifests [ ] 15/13343 1d16h 06:53:38 INFO - manifests [ ] 17/13343 1d11h 06:53:38 INFO - manifests [ ] 19/13343 1d08h 06:53:38 INFO - manifests [ ] 21/13343 28h14m 06:53:38 INFO - manifests [ ] 25/13343 23h45m 06:53:38 INFO - manifests [ ] 31/13343 19h10m 06:53:38 INFO - manifests [ ] 36/13343 16h35m 06:53:38 INFO - manifests [ ] 38/13343 15h49m 06:53:38 INFO - manifests [ ] 41/13343 14h46m 06:53:38 INFO - manifests [ ] 43/13343 14h12m 06:53:38 INFO - manifests [ ] 45/13343 13h40m 06:53:38 INFO - manifests [ ] 47/13343 13h12m 06:53:38 INFO - manifests [ ] 49/13343 12h47m 06:53:38 INFO - manifests [ ] 51/13343 12h23m 06:53:38 INFO - manifests [ ] 53/13343 12h01m 06:53:38 INFO - manifests [ ] 55/13343 11h41m 06:53:38 INFO - manifests [ ] 57/13343 11h23m 06:53:38 INFO - manifests [ ] 59/13343 11h06m 06:53:38 INFO - manifests [ ] 61/13343 10h50m 06:53:38 INFO - manifests [ ] 63/13343 10h35m 06:53:38 INFO - manifests [ ] 65/13343 10h21m 06:53:38 INFO - manifests [ ] 67/13343 10h08m 06:53:38 INFO - manifests [ ] 69/13343 9h56m 06:53:38 INFO - manifests [ ] 71/13343 9h45m 06:53:38 INFO - manifests [ ] 73/13343 9h34m 06:53:38 INFO - manifests [ ] 75/13343 9h24m 06:53:38 INFO - manifests [ ] 77/13343 9h14m 06:53:38 INFO - manifests [ ] 79/13343 9h05m 06:53:38 INFO - manifests [ ] 81/13343 8h57m 06:53:38 INFO - manifests [ ] 83/13343 8h49m 06:53:38 INFO - manifests [ ] 85/13343 8h41m 06:53:38 INFO - manifests [ ] 87/13343 8h34m 06:53:38 INFO - manifests [ ] 89/13343 8h28m 06:53:38 INFO - manifests [ ] 90/13343 8h24m 06:53:38 INFO - manifests [ ] 91/13343 8h21m 06:53:38 INFO - manifests [ ] 92/13343 8h18m 06:53:38 INFO - manifests [ ] 93/13343 8h15m 06:53:38 INFO - manifests [ ] 94/13343 8h12m 06:53:38 INFO - manifests [ ] 95/13343 8h10m 06:53:38 INFO - manifests [ ] 96/13343 8h07m 06:53:38 INFO - manifests [ ] 99/13343 7h55m 06:53:38 INFO - manifests [==> ] 900/13343 48m48s 06:53:38 INFO - manifests [======================> ] 6559/13343 3m40s 06:53:38 INFO - manifests [===================================> ] 10240/13343 1m05sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:53:38 INFO - (existing repository shared store: C:\builds\hg-shared\8ba995b74e18334ab3707f27e9eb8f4e37ba3d29\.hg) 06:53:38 INFO - (pulling to obtain 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd) 06:53:38 INFO - searching for changes 06:53:38 INFO - adding changesets 06:53:38 INFO - adding manifests 06:53:38 INFO - 06:53:38 INFO - 06:53:38 INFO - transaction abort! 06:53:38 INFO - rollback completed 06:53:38 INFO - stream ended unexpectedly (got 0 bytes, expected 4) 06:53:38 INFO - (retrying after network failure on attempt 2 of 3) 06:53:38 INFO - (waiting 7.03s before retry) 06:55:26 INFO - 06:55:26 INFO - searching [ <=> ] 2 06:55:26 INFO - searching [ <=> ] 3 06:55:26 INFO - searching [ <=> ] 5 06:55:26 INFO - 06:55:26 INFO - 06:55:26 INFO - changesets [ ] 1/13343 06:55:26 INFO - changesets [=============> ] 3669/13343 06:55:26 INFO - changesets [==========================> ] 6811/13343 06:55:26 INFO - changesets [================================> ] 9130/13343 02s 06:55:26 INFO - changesets [=========================================> ] 11553/13343 01s 06:55:26 INFO - 06:55:26 INFO - 06:55:26 INFO - manifests [ ] 1/13343 06:55:26 INFO - manifests [ ] 3/13343 2w06d 06:55:26 INFO - manifests [ ] 5/13343 9d15h 06:55:26 INFO - manifests [ ] 7/13343 6d11h 06:55:26 INFO - manifests [ ] 9/13343 4d21h 06:55:26 INFO - manifests [ ] 11/13343 3d22h 06:55:26 INFO - manifests [ ] 13/13343 3d07h 06:55:26 INFO - manifests [ ] 15/13343 2d20h 06:55:26 INFO - manifests [ ] 17/13343 2d12h 06:55:26 INFO - manifests [ ] 19/13343 2d06h 06:55:26 INFO - manifests [ ] 21/13343 2d00h 06:55:26 INFO - manifests [ ] 25/13343 1d17h 06:55:26 INFO - manifests [ ] 31/13343 1d09h 06:55:26 INFO - manifests [ ] 36/13343 27h50m 06:55:26 INFO - manifests [ ] 38/13343 26h28m 06:55:26 INFO - manifests [ ] 41/13343 24h37m 06:55:26 INFO - manifests [ ] 43/13343 23h34m 06:55:26 INFO - manifests [ ] 45/13343 22h37m 06:55:26 INFO - manifests [ ] 47/13343 21h45m 06:55:26 INFO - manifests [ ] 49/13343 20h58m 06:55:26 INFO - manifests [ ] 51/13343 20h15m 06:55:26 INFO - manifests [ ] 53/13343 19h35m 06:55:26 INFO - manifests [ ] 55/13343 18h58m 06:55:26 INFO - manifests [ ] 57/13343 18h24m 06:55:26 INFO - manifests [ ] 59/13343 17h52m 06:55:26 INFO - manifests [ ] 61/13343 17h23m 06:55:26 INFO - manifests [ ] 63/13343 16h55m 06:55:26 INFO - manifests [ ] 65/13343 16h29m 06:55:26 INFO - manifests [ ] 67/13343 16h05m 06:55:26 INFO - manifests [ ] 69/13343 15h43m 06:55:26 INFO - manifests [ ] 71/13343 15h21m 06:55:26 INFO - manifests [ ] 73/13343 15h01m 06:55:26 INFO - manifests [ ] 75/13343 14h42m 06:55:26 INFO - manifests [ ] 77/13343 14h24m 06:55:26 INFO - manifests [ ] 79/13343 14h07m 06:55:26 INFO - manifests [ ] 81/13343 13h51m 06:55:26 INFO - manifests [ ] 83/13343 13h35m 06:55:26 INFO - manifests [ ] 85/13343 13h21m 06:55:26 INFO - manifests [ ] 87/13343 13h07m 06:55:26 INFO - manifests [ ] 89/13343 12h54m 06:55:26 INFO - manifests [ ] 91/13343 12h41m 06:55:26 INFO - manifests [ ] 93/13343 12h30m 06:55:26 INFO - manifests [ ] 95/13343 12h18m 06:55:26 INFO - manifests [ ] 96/13343 12h13m 06:55:26 INFO - manifests [ ] 99/13343 11h53m 06:55:26 INFO - manifests [==> ] 986/13343 1h07m 06:55:26 INFO - manifests [=======================> ] 6908/13343 4m57s 06:55:26 INFO - manifests [===================================> ] 10240/13343 1m37s 06:55:26 INFO - manifests [===========================================> ] 11833/13343 41s 06:55:26 INFO - 06:55:26 INFO - 06:55:26 INFO - files [> ] 1200/54851 1m38s 06:55:26 INFO - files [> ] 2091/54851 1m21sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:55:26 INFO - (existing repository shared store: C:\builds\hg-shared\8ba995b74e18334ab3707f27e9eb8f4e37ba3d29\.hg) 06:55:26 INFO - (pulling to obtain 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd) 06:55:26 INFO - searching for changes 06:55:26 INFO - adding changesets 06:55:26 INFO - adding manifests 06:55:26 INFO - adding file changes 06:55:26 INFO - 06:55:26 INFO - 06:55:26 INFO - transaction abort! 06:55:26 INFO - rollback completed 06:55:26 INFO - stream ended unexpectedly (got 0 bytes, expected 4) 06:55:26 INFO - Traceback (most recent call last): 06:55:26 INFO - File "mercurial\dispatch.pyc", line 204, in _runcatch 06:55:26 INFO - File "mercurial\dispatch.pyc", line 880, in _dispatch 06:55:26 INFO - File "mercurial\dispatch.pyc", line 637, in runcommand 06:55:26 INFO - File "mercurial\extensions.pyc", line 210, in closure 06:55:26 INFO - File "hgext\color.pyc", line 503, in colorcmd 06:55:26 INFO - File "mercurial\dispatch.pyc", line 1010, in _runcommand 06:55:26 INFO - File "mercurial\dispatch.pyc", line 971, in checkargs 06:55:26 INFO - File "mercurial\dispatch.pyc", line 877, in 06:55:26 INFO - File "mercurial\util.pyc", line 1036, in check 06:55:26 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 163, in robustcheckout 06:55:26 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 289, in _docheckout 06:55:26 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 172, in callself 06:55:26 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 348, in _docheckout 06:55:26 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 172, in callself 06:55:26 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 347, in _docheckout 06:55:26 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 262, in handlepullabort 06:55:26 INFO - Abort: reached maximum number of network attempts; giving up 06:55:26 INFO - abort: reached maximum number of network attempts; giving up 06:55:26 ERROR - Return code: 255 06:55:26 INFO - rmtree: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 06:55:26 INFO - Using _rmtree_windows ... 06:55:26 INFO - retry: Calling _rmtree_windows with args: ('c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src',), kwargs: {}, attempt #1 06:55:27 INFO - retry: attempt #4 caught exception: repo checkout failed! 06:55:27 INFO - retry: Failed, sleeping 300 seconds before retrying 07:00:27 INFO - retry: Calling _get_revision with args: (, 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src'), kwargs: {}, attempt #5 07:00:27 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version'] 07:00:27 INFO - Copy/paste: hg --config ui.merge=internal:merge --version 07:00:27 INFO - Mercurial Distributed SCM (version 3.9.1) 07:00:27 INFO - (see https://mercurial-scm.org for more information) 07:00:27 INFO - Copyright (C) 2005-2016 Matt Mackall and others 07:00:27 INFO - This is free software; see the source for copying conditions. There is NO 07:00:27 INFO - warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. 07:00:27 INFO - Return code: 0 07:00:27 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall'] 07:00:27 INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall 07:00:27 INFO - checking encoding (cp1252)... 07:00:27 INFO - checking Python executable (c:\mozilla-build\hg\hg.exe) 07:00:27 INFO - checking Python version (2.7.12) 07:00:27 INFO - checking Python lib (c:\mozilla-build\hg\lib\library.zip)... 07:00:27 INFO - checking Mercurial version (3.9.1) 07:00:27 INFO - checking Mercurial custom build () 07:00:27 INFO - checking module policy (c) 07:00:27 INFO - checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)... 07:00:27 INFO - checking templates (c:\mozilla-build\hg\templates)... 07:00:27 INFO - checking default template (c:\mozilla-build\hg\templates\map-cmdline.default) 07:00:27 INFO - checking commit editor... (notepad) 07:00:27 INFO - checking username (Mozilla Release Engineering ) 07:00:27 INFO - no problems detected 07:00:27 INFO - Return code: 0 07:00:27 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/projects/ash', 'c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src', '--sharebase', 'C:/builds/hg-shared', '--revision', '2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd'] 07:00:27 INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\ash-w64-d-00000000000000000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/projects/ash c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src --sharebase C:/builds/hg-shared --revision 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd 07:02:06 INFO - 07:02:06 INFO - searching [ <=> ] 3 07:02:06 INFO - searching [ <=> ] 5 07:02:06 INFO - 07:02:06 INFO - 07:02:06 INFO - changesets [===========> ] 3097/13343 07:02:06 INFO - changesets [========================> ] 6842/13343 02s 07:02:06 INFO - changesets [===================================> ] 9856/13343 02s 07:02:06 INFO - changesets [============================================> ] 12297/13343 01s 07:02:06 INFO - 07:02:06 INFO - 07:02:06 INFO - manifests [ ] 4/13343 2h31m 07:02:06 INFO - manifests [ ] 6/13343 2h27m 07:02:06 INFO - manifests [ ] 8/13343 2h26m 07:02:06 INFO - manifests [ ] 10/13343 2h26m 07:02:06 INFO - manifests [ ] 12/13343 2h26m 07:02:06 INFO - manifests [ ] 14/13343 2h26m 07:02:06 INFO - manifests [ ] 16/13343 2h27m 07:02:06 INFO - manifests [ ] 18/13343 2h28m 07:02:06 INFO - manifests [ ] 20/13343 2h28m 07:02:06 INFO - manifests [ ] 22/13343 2h29m 07:02:06 INFO - manifests [ ] 30/13343 1h59m 07:02:06 INFO - manifests [ ] 32/13343 2h02m 07:02:06 INFO - manifests [ ] 37/13343 1h54m 07:02:06 INFO - manifests [ ] 40/13343 1h53m 07:02:06 INFO - manifests [ ] 42/13343 1h56m 07:02:06 INFO - manifests [ ] 44/13343 1h58m 07:02:06 INFO - manifests [ ] 46/13343 2h01m 07:02:06 INFO - manifests [ ] 48/13343 2h03m 07:02:06 INFO - manifests [ ] 50/13343 2h05m 07:02:06 INFO - manifests [ ] 52/13343 2h08m 07:02:06 INFO - manifests [ ] 54/13343 2h10m 07:02:06 INFO - manifests [ ] 56/13343 2h12m 07:02:06 INFO - manifests [ ] 58/13343 2h14m 07:02:06 INFO - manifests [ ] 60/13343 2h16m 07:02:06 INFO - manifests [ ] 62/13343 2h18m 07:02:06 INFO - manifests [ ] 64/13343 2h19m 07:02:06 INFO - manifests [ ] 66/13343 2h21m 07:02:06 INFO - manifests [ ] 68/13343 2h23m 07:02:06 INFO - manifests [ ] 70/13343 2h24m 07:02:06 INFO - manifests [ ] 72/13343 2h26m 07:02:06 INFO - manifests [ ] 74/13343 2h28m 07:02:06 INFO - manifests [ ] 76/13343 2h29m 07:02:06 INFO - manifests [ ] 78/13343 2h30m 07:02:06 INFO - manifests [ ] 80/13343 2h32m 07:02:06 INFO - manifests [ ] 82/13343 2h33m 07:02:06 INFO - manifests [ ] 84/13343 2h35m 07:02:06 INFO - manifests [ ] 86/13343 2h36m 07:02:06 INFO - manifests [ ] 88/13343 2h37m 07:02:06 INFO - manifests [ ] 90/13343 2h39m 07:02:06 INFO - manifests [ ] 92/13343 2h40m 07:02:06 INFO - manifests [ ] 93/13343 2h41m 07:02:06 INFO - manifests [ ] 94/13343 2h41m 07:02:06 INFO - manifests [ ] 95/13343 2h42m 07:02:06 INFO - manifests [ ] 96/13343 2h43m 07:02:06 INFO - manifests [ ] 99/13343 2h40m 07:02:06 INFO - manifests [==> ] 992/13343 14m57s 07:02:06 INFO - manifests [========================> ] 7181/13343 1m03s 07:02:06 INFO - manifests [=====================================> ] 10240/13343 23s 07:02:06 INFO - manifests [===========================================> ] 11833/13343 10s 07:02:06 INFO - 07:02:06 INFO - ensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 07:02:06 INFO - (sharing from existing pooled repository 8ba995b74e18334ab3707f27e9eb8f4e37ba3d29) 07:02:06 INFO - searching for changes 07:02:06 INFO - adding changesets 07:02:06 INFO - adding manifests 07:02:06 INFO - adding file changes 07:02:06 INFO - transaction abort! 07:02:07 INFO - rollback completed 07:02:07 INFO - stream ended unexpectedly (got 76687 bytes, expected 169877595) 07:02:07 INFO - (retrying after network failure on attempt 1 of 3) 07:02:07 INFO - (waiting 5.79s before retry) 07:04:26 INFO - 07:04:26 INFO - searching [ <=> ] 2 07:04:26 INFO - searching [ <=> ] 3 07:04:26 INFO - searching [ <=> ] 5 07:04:26 INFO - 07:04:26 INFO - 07:04:26 INFO - changesets [ ] 1/13343 07:04:26 INFO - changesets [===============> ] 4065/13343 07:04:26 INFO - changesets [============================> ] 7334/13343 07:04:26 INFO - changesets [===================================> ] 10041/13343 01s 07:04:26 INFO - changesets [============================================> ] 12274/13343 01s 07:04:26 INFO - 07:04:26 INFO - 07:04:26 INFO - manifests [ ] 1/13343 07:04:26 INFO - manifests [ ] 3/13343 07:04:26 INFO - manifests [ ] 5/13343 2h29m 07:04:26 INFO - manifests [ ] 7/13343 2h27m 07:04:26 INFO - manifests [ ] 9/13343 2h26m 07:04:26 INFO - manifests [ ] 11/13343 2h26m 07:04:26 INFO - manifests [ ] 13/13343 2h26m 07:04:26 INFO - manifests [ ] 15/13343 2h26m 07:04:26 INFO - manifests [ ] 17/13343 2h27m 07:04:26 INFO - manifests [ ] 19/13343 2h27m 07:04:26 INFO - manifests [ ] 21/13343 2h28m 07:04:26 INFO - manifests [ ] 25/13343 2h17m 07:04:26 INFO - manifests [ ] 31/13343 2h00m 07:04:26 INFO - manifests [ ] 36/13343 1h52m 07:04:26 INFO - manifests [ ] 38/13343 1h54m 07:04:26 INFO - manifests [ ] 41/13343 1h54m 07:04:26 INFO - manifests [ ] 43/13343 1h56m 07:04:26 INFO - manifests [ ] 45/13343 1h59m 07:04:26 INFO - manifests [ ] 47/13343 2h01m 07:04:26 INFO - manifests [ ] 49/13343 2h03m 07:04:26 INFO - manifests [ ] 51/13343 2h06m 07:04:26 INFO - manifests [ ] 53/13343 2h08m 07:04:26 INFO - manifests [ ] 55/13343 2h10m 07:04:26 INFO - manifests [ ] 57/13343 2h12m 07:04:26 INFO - manifests [ ] 59/13343 2h14m 07:04:26 INFO - manifests [ ] 61/13343 2h16m 07:04:26 INFO - manifests [ ] 63/13343 2h18m 07:04:26 INFO - manifests [ ] 65/13343 2h19m 07:04:26 INFO - manifests [ ] 67/13343 2h21m 07:04:26 INFO - manifests [ ] 69/13343 2h23m 07:04:26 INFO - manifests [ ] 71/13343 2h24m 07:04:26 INFO - manifests [ ] 73/13343 2h26m 07:04:26 INFO - manifests [ ] 75/13343 2h27m 07:04:26 INFO - manifests [ ] 77/13343 2h29m 07:04:26 INFO - manifests [ ] 79/13343 2h30m 07:04:26 INFO - manifests [ ] 81/13343 2h32m 07:04:26 INFO - manifests [ ] 83/13343 2h33m 07:04:26 INFO - manifests [ ] 85/13343 2h35m 07:04:26 INFO - manifests [ ] 86/13343 2h36m 07:04:26 INFO - manifests [ ] 87/13343 2h36m 07:04:26 INFO - manifests [ ] 88/13343 2h37m 07:04:26 INFO - manifests [ ] 89/13343 2h38m 07:04:26 INFO - manifests [ ] 90/13343 2h39m 07:04:26 INFO - manifests [ ] 91/13343 2h39m 07:04:26 INFO - manifests [ ] 92/13343 2h40m 07:04:26 INFO - manifests [ ] 93/13343 2h41m 07:04:26 INFO - manifests [ ] 94/13343 2h42m 07:04:26 INFO - manifests [ ] 95/13343 2h42m 07:04:26 INFO - manifests [ ] 96/13343 2h43m 07:04:26 INFO - manifests [ ] 99/13343 2h41m 07:04:26 INFO - manifests [==> ] 939/13343 15m56s 07:04:26 INFO - manifests [=======================> ] 6710/13343 1m13s 07:04:26 INFO - manifests [=====================================> ] 10240/13343 23s 07:04:26 INFO - manifests [===========================================> ] 11821/13343 10sensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 07:04:26 INFO - (existing repository shared store: C:\builds\hg-shared\8ba995b74e18334ab3707f27e9eb8f4e37ba3d29\.hg) 07:04:26 INFO - (pulling to obtain 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd) 07:04:26 INFO - searching for changes 07:04:26 INFO - adding changesets 07:04:26 INFO - adding manifests 07:04:26 INFO - 07:04:26 INFO - 07:04:26 INFO - transaction abort! 07:04:26 INFO - rollback completed 07:04:26 INFO - stream ended unexpectedly (got 248761 bytes, expected 842402410) 07:04:26 INFO - (retrying after network failure on attempt 2 of 3) 07:04:26 INFO - (waiting 8.99s before retry) 07:06:12 INFO - 07:06:12 INFO - searching [ <=> ] 2 07:06:12 INFO - searching [ <=> ] 3 07:06:12 INFO - searching [ <=> ] 5 07:06:12 INFO - 07:06:12 INFO - 07:06:12 INFO - changesets [ ] 1/13343 07:06:12 INFO - changesets [==============> ] 3955/13343 07:06:12 INFO - changesets [===========================> ] 7107/13343 07:06:12 INFO - changesets [==================================> ] 9743/13343 02s 07:06:12 INFO - changesets [==========================================> ] 11931/13343 01s 07:06:12 INFO - 07:06:12 INFO - 07:06:12 INFO - manifests [ ] 1/13343 07:06:12 INFO - manifests [ ] 3/13343 8d08h 07:06:12 INFO - manifests [ ] 5/13343 4d05h 07:06:12 INFO - manifests [ ] 7/13343 2d21h 07:06:12 INFO - manifests [ ] 9/13343 2d04h 07:06:12 INFO - manifests [ ] 11/13343 1d18h 07:06:12 INFO - manifests [ ] 13/13343 1d12h 07:06:12 INFO - manifests [ ] 15/13343 1d07h 07:06:12 INFO - manifests [ ] 17/13343 27h02m 07:06:12 INFO - manifests [ ] 19/13343 24h19m 07:06:12 INFO - manifests [ ] 21/13343 22h08m 07:06:12 INFO - manifests [ ] 25/13343 18h40m 07:06:12 INFO - manifests [ ] 31/13343 15h06m 07:06:12 INFO - manifests [ ] 36/13343 13h05m 07:06:12 INFO - manifests [ ] 38/13343 12h32m 07:06:12 INFO - manifests [ ] 41/13343 11h43m 07:06:12 INFO - manifests [ ] 43/13343 11h17m 07:06:12 INFO - manifests [ ] 45/13343 10h54m 07:06:12 INFO - manifests [ ] 47/13343 10h33m 07:06:12 INFO - manifests [ ] 49/13343 10h14m 07:06:12 INFO - manifests [ ] 51/13343 9h57m 07:06:12 INFO - manifests [ ] 53/13343 9h41m 07:06:12 INFO - manifests [ ] 55/13343 9h26m 07:06:12 INFO - manifests [ ] 57/13343 9h13m 07:06:12 INFO - manifests [ ] 59/13343 9h00m 07:06:12 INFO - manifests [ ] 61/13343 8h48m 07:06:12 INFO - manifests [ ] 63/13343 8h38m 07:06:12 INFO - manifests [ ] 65/13343 8h28m 07:06:12 INFO - manifests [ ] 67/13343 8h18m 07:06:12 INFO - manifests [ ] 69/13343 8h09m 07:06:12 INFO - manifests [ ] 71/13343 8h01m 07:06:12 INFO - manifests [ ] 73/13343 7h53m 07:06:12 INFO - manifests [ ] 75/13343 7h46m 07:06:12 INFO - manifests [ ] 77/13343 7h39m 07:06:12 INFO - manifests [ ] 79/13343 7h32m 07:06:12 INFO - manifests [ ] 81/13343 7h26m 07:06:12 INFO - manifests [ ] 83/13343 7h20m 07:06:12 INFO - manifests [ ] 85/13343 7h15m 07:06:12 INFO - manifests [ ] 87/13343 7h10m 07:06:12 INFO - manifests [ ] 89/13343 7h05m 07:06:12 INFO - manifests [ ] 91/13343 7h00m 07:06:12 INFO - manifests [ ] 92/13343 6h58m 07:06:12 INFO - manifests [ ] 93/13343 6h56m 07:06:12 INFO - manifests [ ] 94/13343 6h54m 07:06:12 INFO - manifests [ ] 95/13343 6h52m 07:06:12 INFO - manifests [ ] 96/13343 6h50m 07:06:12 INFO - manifests [ ] 99/13343 6h40m 07:06:12 INFO - manifests [==> ] 977/13343 37m40s 07:06:12 INFO - manifests [======================> ] 6628/13343 3m02s 07:06:12 INFO - manifests [=====================================> ] 10240/13343 55s 07:06:12 INFO - manifests [===========================================> ] 11833/13343 24s 07:06:12 INFO - 07:06:12 INFO - 07:06:12 INFO - files [ ] 1/54851 07:06:12 INFO - files [ ] 826/54851 4h33mensuring https://hg.mozilla.org/projects/ash@2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd is available at c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 07:06:12 INFO - (existing repository shared store: C:\builds\hg-shared\8ba995b74e18334ab3707f27e9eb8f4e37ba3d29\.hg) 07:06:12 INFO - (pulling to obtain 2b927c6e38174f7c39a4e4cdb39bc876fb51fdcd) 07:06:12 INFO - searching for changes 07:06:12 INFO - adding changesets 07:06:12 INFO - adding manifests 07:06:12 INFO - adding file changes 07:06:12 INFO - 07:06:12 INFO - 07:06:12 INFO - transaction abort! 07:06:13 INFO - rollback completed 07:06:13 INFO - stream ended unexpectedly (got 38032 bytes, expected 544499817) 07:06:13 INFO - Traceback (most recent call last): 07:06:13 INFO - File "mercurial\dispatch.pyc", line 204, in _runcatch 07:06:13 INFO - File "mercurial\dispatch.pyc", line 880, in _dispatch 07:06:13 INFO - File "mercurial\dispatch.pyc", line 637, in runcommand 07:06:13 INFO - File "mercurial\extensions.pyc", line 210, in closure 07:06:13 INFO - File "hgext\color.pyc", line 503, in colorcmd 07:06:13 INFO - File "mercurial\dispatch.pyc", line 1010, in _runcommand 07:06:13 INFO - File "mercurial\dispatch.pyc", line 971, in checkargs 07:06:13 INFO - File "mercurial\dispatch.pyc", line 877, in 07:06:13 INFO - File "mercurial\util.pyc", line 1036, in check 07:06:13 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 163, in robustcheckout 07:06:13 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 289, in _docheckout 07:06:13 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 172, in callself 07:06:13 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 348, in _docheckout 07:06:13 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 172, in callself 07:06:13 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 347, in _docheckout 07:06:13 INFO - File "c:/builds/moz2_slave/ash-w64-d-00000000000000000000/scripts/external_tools/robustcheckout.py", line 262, in handlepullabort 07:06:13 INFO - Abort: reached maximum number of network attempts; giving up 07:06:13 INFO - abort: reached maximum number of network attempts; giving up 07:06:13 ERROR - Return code: 255 07:06:13 INFO - rmtree: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\src 07:06:13 INFO - Using _rmtree_windows ... 07:06:13 INFO - retry: Calling _rmtree_windows with args: ('c:\\builds\\moz2_slave\\ash-w64-d-00000000000000000000\\build\\src',), kwargs: {}, attempt #1 07:06:13 INFO - retry: attempt #5 caught exception: repo checkout failed! 07:06:13 FATAL - Automation Error: Can't checkout https://hg.mozilla.org/projects/ash! 07:06:13 FATAL - Caught exception: repo checkout failed! 07:06:13 FATAL - Caught exception: repo checkout failed! 07:06:13 FATAL - Caught exception: repo checkout failed! 07:06:13 FATAL - Caught exception: repo checkout failed! 07:06:13 FATAL - Caught exception: repo checkout failed! 07:06:13 FATAL - Running post_fatal callback... 07:06:13 ERROR - setting return code to 2 because fatal was called 07:06:13 WARNING - setting return code to 2 07:06:13 FATAL - Exiting -1 07:06:13 INFO - [mozharness: 2017-02-20 15:06:13.689000Z] Finished checkout-sources step (failed) 07:06:13 INFO - Running post-run listener: _summarize 07:06:13 ERROR - # TBPL FAILURE # 07:06:13 INFO - [mozharness: 2017-02-20 15:06:13.689000Z] FxDesktopBuild summary: 07:06:13 ERROR - # TBPL FAILURE # 07:06:13 INFO - Running post-run listener: copy_logs_to_upload_dir 07:06:13 INFO - Copying logs to upload dir... 07:06:13 INFO - mkdir: c:\builds\moz2_slave\ash-w64-d-00000000000000000000\build\upload\logs program finished with exit code -1 elapsedTime=2509.820000 ========= master_lag: 0.05 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 41 mins, 49 secs) (at 2017-02-20 07:06:16.521628) ========= ========= Started set props: buildid stage_platform builduid (results: 0, elapsed: 0 secs) (at 2017-02-20 07:06:16.525187) ========= 'bash' '-c' 'for file in `ls -1`; do cat $file; done' in dir c:\builds\moz2_slave\ash-w64-d-00000000000000000000\properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv BUILDBOT_PATH=C:\mozilla-build\buildbotve CHOCOLATEYINSTALL=C:\ProgramData\chocolatey COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=B-2008-SPOT-029 COMSPEC=C:\Windows\system32\cmd.exe CVS_RSH=ssh DXSDK_DIR=C:\Program Files (x86)\Microsoft DirectX SDK (June 2010)\ EDITOR=emacs.exe FP_NO_HOST_CHECK=NO GIT_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/git-shared HG_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/hg-shared HOME=c:/Users/cltbld HOMEDRIVE=C: HOMEPATH=\ HOSTTYPE=i686 IDLEIZER_HALT_ON_IDLE=true INPUTRC=C:/mozilla-build/msys/etc/inputrc LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOG="c:\runner\buildbot-startup.log" LOGNAME=cltbld LOGONSERVER=\\B-2008-SPOT-029 MACHTYPE=i686-pc-msys MAKE_MODE=unix MOZBUILDDIR=C:\mozilla-build MOZILLABUILD=C:\mozilla-build MOZ_TOOLS=C:\mozilla-build\moztools-x64 MSYSTEM=MINGW32 NUMBER_OF_PROCESSORS=16 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\buildbotve\Scripts;c:\ProgramData\chocolatey\bin;.;c:\opt\runner;c:\mozilla-build\buildbotve;c:\mozilla-build\python27;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;.;C:\mozilla-build\msys\local\bin;c:\mozilla-build\moztools-x64\bin;c:\mozilla-build\vim\vim72 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 62 Stepping 4, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=3e04 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PS1=\[\033]0;$MSYSTEM:\w\007 \033[32m\]\u@\h \[\033[33m\w\033[0m\] $ PSMODULEPATH=C:\Windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files (x86)\AWS Tools\PowerShell\ PUBLIC=C:\Users\Public PWD=c:/Users/cltbld RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg SHELL=C:/mozilla-build/msys/bin/sh SHLVL=1 SSH_AGENT_PID=2268 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048 SYSTEMDRIVE=C: SYSTEMROOT=C:\Windows TEMP=C:/Users/cltbld/AppData/Local/Temp TERM=cygwin TMP=C:/Users/cltbld/AppData/Local/Temp USERDOMAIN=B-2008-SPOT-029 USERNAME=cltbld USERPROFILE=C:\Users\cltbld VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\ VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\ VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\ WINDIR=C:\Windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log WIX_351728_PATH=c:/mozilla-build/wix-351728 _=C:\mozilla-build\buildbotve\Scripts\python using PTY: False buildid:20170220062259 builduid:ba9a709595bd431b97418cb594d0bf2d stage_platform:win64-debug program finished with exit code 0 elapsedTime=0.116000 buildid: '20170220062259' stage_platform: 'win64-debug' builduid: 'ba9a709595bd431b97418cb594d0bf2d' ========= master_lag: 0.03 ========= ========= Finished set props: buildid stage_platform builduid (results: 0, elapsed: 0 secs) (at 2017-02-20 07:06:16.667441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 07:06:16.668389) ========= 'rm' '-f' 'oauth.txt' in dir c:\builds\moz2_slave\ash-w64-d-00000000000000000000\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv BUILDBOT_PATH=C:\mozilla-build\buildbotve CHOCOLATEYINSTALL=C:\ProgramData\chocolatey COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=B-2008-SPOT-029 COMSPEC=C:\Windows\system32\cmd.exe CVS_RSH=ssh DXSDK_DIR=C:\Program Files (x86)\Microsoft DirectX SDK (June 2010)\ EDITOR=emacs.exe FP_NO_HOST_CHECK=NO GIT_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/git-shared HG_SHARE_BASE_DIR=C:/mozilla-build/msys/builds/hg-shared HOME=c:/Users/cltbld HOMEDRIVE=C: HOMEPATH=\ HOSTTYPE=i686 IDLEIZER_HALT_ON_IDLE=true INPUTRC=C:/mozilla-build/msys/etc/inputrc LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOG="c:\runner\buildbot-startup.log" LOGNAME=cltbld LOGONSERVER=\\B-2008-SPOT-029 MACHTYPE=i686-pc-msys MAKE_MODE=unix MOZBUILDDIR=C:\mozilla-build MOZILLABUILD=C:\mozilla-build MOZ_TOOLS=C:\mozilla-build\moztools-x64 MSYSTEM=MINGW32 NUMBER_OF_PROCESSORS=16 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\buildbotve\Scripts;c:\ProgramData\chocolatey\bin;.;c:\opt\runner;c:\mozilla-build\buildbotve;c:\mozilla-build\python27;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;.;C:\mozilla-build\msys\local\bin;c:\mozilla-build\moztools-x64\bin;c:\mozilla-build\vim\vim72 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 62 Stepping 4, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=3e04 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PS1=\[\033]0;$MSYSTEM:\w\007 \033[32m\]\u@\h \[\033[33m\w\033[0m\] $ PSMODULEPATH=C:\Windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files (x86)\AWS Tools\PowerShell\ PUBLIC=C:\Users\Public PWD=c:/Users/cltbld RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg SHELL=C:/mozilla-build/msys/bin/sh SHLVL=1 SSH_AGENT_PID=2268 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-HIoHIx4048/agent.4048 SYSTEMDRIVE=C: SYSTEMROOT=C:\Windows TEMP=C:/Users/cltbld/AppData/Local/Temp TERM=cygwin TMP=C:/Users/cltbld/AppData/Local/Temp USERDOMAIN=B-2008-SPOT-029 USERNAME=cltbld USERPROFILE=C:\Users\cltbld VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\ VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\ VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\ WINDIR=C:\Windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log WIX_351728_PATH=c:/mozilla-build/wix-351728 _=C:\mozilla-build\buildbotve\Scripts\python using PTY: False program finished with exit code 0 elapsedTime=0.106000 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 07:06:16.782004) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2017-02-20 07:06:16.782960) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2017-02-20 07:06:17.081610) ========= ========= Total master_lag: 0.13 =========