builder: mozilla-beta-win64-add-on-devel slave: b-2008-spot-029 starttime: 1485240883.03 results: failure (2) buildid: 20170123215343 builduid: bfd32c45eab04c74a269662b5c596776 revision: 1522cb56a651b62675f392d4064bd4365aac07f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 22:54:43.029763) ========= master: http://buildbot-master94.bb.releng.use1.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 22:54:43.030290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 22:54:43.030574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 22:54:43.188774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 22:54:43.189146) ========= '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\m-beta-w64-add-on-devel-000000\. (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=3144 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-snhTIW4044/agent.4044 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-01-23 22:54:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 31.0K=0.4s 2017-01-23 22:54:42 (31.0 KB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.894000 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 22:54:45.095559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 22:54:45.096571) ========= 'rm' '-rf' 'scripts' 'properties' in dir c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\. (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=3144 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-snhTIW4044/agent.4044 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-01-23 22:54:45.211634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-23 22:54:45.212622) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1522cb56a651b62675f392d4064bd4365aac07f4 --destination scripts --debug' in dir c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1522cb56a651b62675f392d4064bd4365aac07f4 --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=3144 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-snhTIW4044/agent.4044 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-01-23 22:54:43,085 truncating revision to first 12 chars 2017-01-23 22:54:43,085 Setting DEBUG logging. 2017-01-23 22:54:43,085 attempt 1/10 2017-01-23 22:54:43,085 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1522cb56a651?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 22:54:44,407 unpacking tar archive at: mozilla-beta-1522cb56a651/testing/mozharness/ 2017-01-23 22:54:44,552 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=2.380000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-23 22:54:47.608489) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 22:54:47.609457) ========= script_repo_revision: 1522cb56a651b62675f392d4064bd4365aac07f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 22:54:47.609833) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 22:54:47.610128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 22:54:47.618770) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 44 mins, 58 secs) (at 2017-01-23 22:54:47.619077) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/fx_desktop_build.py' '--config' 'builds/releng_base_windows_64_builds.py' '--custom-build-variant-cfg' 'add-on-devel' '--config' 'balrog/production.py' '--branch' 'mozilla-beta' '--build-pool' 'production' in dir c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\. (timeout 10800 secs) (maxTime 19800 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', 'add-on-devel', '--config', 'balrog/production.py', '--branch', 'mozilla-beta', '--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 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_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 PDBSTR_PATH=/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe 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/m-beta-w64-add-on-devel-000000/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=3144 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-snhTIW4044/agent.4044 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 _=C:\mozilla-build\buildbotve\Scripts\python using PTY: False 22:54:45 INFO - MultiFileLogger online at 20170123 22:54:45 in c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000 22:54:45 INFO - Script was run with '--custom-build-variant-cfg add-on-devel' and 'add-on-devel' matches a key in 'builds/releng_sub_windows_configs/64_add-on-devel.py'. Updating self.config with items from that key's value. 22:54:45 INFO - Script was run with '--branch mozilla-beta' and 'mozilla-beta' matches a key in 'builds/branch_specifics.py'. Updating self.config with items from that key's value. 22:54:45 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. 22:54:45 INFO - The branch 'mozilla-beta' has custom behavior for the platform 'win64-add-on-devel'. Updating self.config with the following from 'platform_overrides' found in 'builds/branch_specifics.py': 22:54:45 INFO - {'update_channel': 'default'} 22:54:45 INFO - To generate a config file based upon options passed and config files used, run script as before but extend options with "--dump-config" 22:54:45 INFO - For a diff of where self.config got its items, run the script again as before but extend options with: "--dump-config-hierarchy" 22:54:45 INFO - Both --dump-config and --dump-config-hierarchy don't actually run any actions. 22:54:45 INFO - We are running this in buildbot, grab the build props 22:54:45 INFO - Using buildbot properties: 22:54:45 INFO - { 22:54:45 INFO - "project": "", 22:54:45 INFO - "product": "firefox", 22:54:45 INFO - "script_repo_revision": "production", 22:54:45 INFO - "scheduler": "mozilla-beta-firefox", 22:54:45 INFO - "repository": "", 22:54:45 INFO - "buildername": "WINNT 6.1 x86-64 add-on-devel mozilla-beta build", 22:54:45 INFO - "buildid": "20170123215343", 22:54:45 INFO - "basedir": "/c/builds/moz2_slave/m-beta-w64-add-on-devel-000000", 22:54:45 INFO - "buildnumber": 26, 22:54:45 INFO - "platform": "win64-add-on-devel", 22:54:45 INFO - "master": "http://buildbot-master94.bb.releng.use1.mozilla.com:8001/", 22:54:45 INFO - "branch": "mozilla-beta", 22:54:45 INFO - "revision": "1522cb56a651b62675f392d4064bd4365aac07f4", 22:54:45 INFO - "slavename": "b-2008-spot-029", 22:54:45 INFO - "builduid": "bfd32c45eab04c74a269662b5c596776", 22:54:45 INFO - "repo_path": "releases/mozilla-beta" 22:54:45 INFO - } 22:54:45 INFO - Setting buildbot property stage_platform to win64-add-on-devel 22:54:45 INFO - mkdir: c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\properties 22:54:45 INFO - Writing buildbot properties ['stage_platform'] to c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\properties\stage_platform 22:54:45 INFO - Writing to file c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\properties\stage_platform 22:54:45 INFO - Contents: 22:54:45 INFO - stage_platform:win64-add-on-devel 22:54:45 WARNING - Try message not found. 22:54:45 INFO - Run as scripts/scripts/fx_desktop_build.py --config builds/releng_base_windows_64_builds.py --custom-build-variant-cfg add-on-devel --config balrog/production.py --branch mozilla-beta --build-pool production 22:54:45 INFO - Determining buildid from buildbot properties 22:54:45 INFO - Setting buildbot property buildid to 20170123215343 22:54:45 INFO - Writing buildbot properties ['buildid'] to c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\properties\buildid 22:54:45 INFO - Writing to file c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\properties\buildid 22:54:45 INFO - Contents: 22:54:45 INFO - buildid:20170123215343 22:54:45 INFO - Determining builduid from buildbot properties 22:54:45 INFO - Setting buildbot property builduid to bfd32c45eab04c74a269662b5c596776 22:54:45 INFO - Writing buildbot properties ['builduid'] to c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\properties\builduid 22:54:45 INFO - Writing to file c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\properties\builduid 22:54:45 INFO - Contents: 22:54:45 INFO - builduid:bfd32c45eab04c74a269662b5c596776 22:54:45 WARNING - signing disabled because MOZ_SIGNING_SERVERS is not set 22:54:45 INFO - Release promotion update channel: default 22:54:45 INFO - Creating virtualenv c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv 22:54:45 INFO - mkdir: c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build 22:54:45 INFO - Running command: ['c:\\mozilla-build\\python27\\python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\venv'] in c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build 22:54:45 INFO - Copy/paste: c:\mozilla-build\python27\python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv 22:54:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:54:48 INFO - New python executable in c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv\Scripts\python.exe 22:54:52 INFO - Installing distribute................................................................................................................................................................................................done. 22:55:07 INFO - Installing pip....................................done. 22:55:07 INFO - Return code: 0 22:55:07 INFO - Getting output from command: ['c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\venv\\Scripts\\pip', '--version'] 22:55:07 INFO - Copy/paste: c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv\Scripts\pip --version 22:55:10 INFO - Reading from file tmpfile_stdout 22:55:10 INFO - Output received: 22:55:10 INFO - pip 9.0.1 from c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv\lib\site-packages\pip-9.0.1-py2.7.egg (python 2.7) 22:55:10 INFO - Using _rmtree_windows ... 22:55:10 INFO - Using _rmtree_windows ... 22:55:10 INFO - Installing requests==2.8.1 into virtualenv c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv 22:55:10 INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\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 0x02599C58>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027A1278>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0248EC70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02805B78>, '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 0x02653D70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029341D8>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build', 'env': {'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'USERNAME': 'cltbld', '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', 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'HOSTTYPE': 'i686', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PWD': 'c:/Users/cltbld', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 'CVS_RSH': 'ssh', 'LOGNAME': 'cltbld', 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'SYSTEMROOT': 'C:\\Windows', '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', 'MAKE_MODE': 'unix', 'TERM': 'cygwin', 'SHELL': 'C:/mozilla-build/msys/bin/sh', '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', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'EDITOR': 'emacs.exe', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'OSTYPE': 'msys', 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'SSH_AGENT_PID': '3144', '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-snhTIW4044/agent.4044', 'XPCOM_DEBUG_BREAK': 'stack-and-abort', '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', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'LOGONSERVER': '\\\\B-2008-SPOT-029', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'HOMEPATH': '\\', 'MOZILLABUILD': 'C:\\mozilla-build', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'FP_NO_HOST_CHECK': 'NO', 'WINDIR': 'C:\\Windows', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'OS_VERSION': '2008', 'PROGRAMFILES': 'C:\\Program Files (x86)', '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', 'PROCESSOR_LEVEL': '6', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'USERPROFILE': 'C:\\Users\\cltbld'}}, attempt #1 22:55:10 INFO - Running command: ['c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'requests==2.8.1'] in c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build 22:55:10 INFO - Copy/paste: c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv\Scripts\pip install --timeout 120 requests==2.8.1 22:55:10 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:55:10 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 22:55:10 INFO - 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 22:55:10 INFO - 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 22:55:10 INFO - 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 22:55:10 INFO - 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 22:55:10 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:55:10 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:55:10 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:55:10 INFO - 'COMPUTERNAME': 'B-2008-SPOT-029', 22:55:10 INFO - 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 22:55:10 INFO - 'CVS_RSH': 'ssh', 22:55:10 INFO - 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 22:55:10 INFO - 'EDITOR': 'emacs.exe', 22:55:10 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:55:10 INFO - 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 22:55:10 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 22:55:10 INFO - 'HOME': 'c:/Users/cltbld', 22:55:10 INFO - 'HOMEDRIVE': 'C:', 22:55:10 INFO - 'HOMEPATH': '\\', 22:55:10 INFO - 'HOSTTYPE': 'i686', 22:55:10 INFO - 'IDLEIZER_HALT_ON_IDLE': 'true', 22:55:10 INFO - 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 22:55:10 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 22:55:10 INFO - 'LOG': '"c:\\runner\\buildbot-startup.log"', 22:55:10 INFO - 'LOGNAME': 'cltbld', 22:55:10 INFO - 'LOGONSERVER': '\\\\B-2008-SPOT-029', 22:55:10 INFO - 'MACHTYPE': 'i686-pc-msys', 22:55:10 INFO - 'MAKE_MODE': 'unix', 22:55:10 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build', 22:55:10 INFO - 'MOZILLABUILD': 'C:\\mozilla-build', 22:55:10 INFO - 'MOZ_AUTOMATION': '1', 22:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:10 INFO - 'MOZ_OBJDIR': 'obj-firefox', 22:55:10 INFO - 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 22:55:10 INFO - 'MSYSTEM': 'MINGW32', 22:55:10 INFO - 'NUMBER_OF_PROCESSORS': '16', 22:55:10 INFO - 'OLDPWD': 'c:/Users/cltbld', 22:55:10 INFO - 'OS': 'Windows_NT', 22:55:10 INFO - 'OSTYPE': 'msys', 22:55:10 INFO - 'OS_VERSION': '2008', 22:55:10 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', 22:55:10 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:55:10 INFO - 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 22:55:10 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:55:10 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:55:10 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 22:55:10 INFO - 'PROCESSOR_LEVEL': '6', 22:55:10 INFO - 'PROCESSOR_REVISION': '3e04', 22:55:10 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:55:10 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:55:10 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:55:10 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:55:10 INFO - 'PROMPT': '$P$G', 22:55:10 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\buildprops.json', 22:55:10 INFO - 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 22:55:10 INFO - 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 22:55:10 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:55:10 INFO - 'PWD': 'c:/Users/cltbld', 22:55:10 INFO - 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 22:55:10 INFO - 'SHELL': 'C:/mozilla-build/msys/bin/sh', 22:55:10 INFO - 'SHLVL': '1', 22:55:10 INFO - 'SSH_AGENT_PID': '3144', 22:55:10 INFO - 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-snhTIW4044/agent.4044', 22:55:10 INFO - 'SYSTEMDRIVE': 'C:', 22:55:10 INFO - 'SYSTEMROOT': 'C:\\Windows', 22:55:10 INFO - 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 22:55:10 INFO - 'TERM': 'cygwin', 22:55:10 INFO - 'TINDERBOX_OUTPUT': '1', 22:55:10 INFO - 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 22:55:10 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 22:55:10 INFO - 'TOOLTOOL_HOME': '/c/builds', 22:55:10 INFO - 'USERDOMAIN': 'B-2008-SPOT-029', 22:55:10 INFO - 'USERNAME': 'cltbld', 22:55:10 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 22:55:10 INFO - 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 22:55:10 INFO - 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 22:55:10 INFO - 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 22:55:10 INFO - 'WINDIR': 'C:\\Windows', 22:55:10 INFO - 'WINDOWS_TRACING_FLAGS': '3', 22:55:10 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 22:55:10 INFO - 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 22:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 22:55:10 INFO - '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'} 22:55:10 INFO - Collecting requests==2.8.1 22:55:11 INFO - Using cached requests-2.8.1-py2.py3-none-any.whl 22:55:12 INFO - Installing collected packages: requests 22:55:12 INFO - Successfully installed requests-2.8.1 22:55:13 INFO - c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\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. 22:55:13 INFO - SNIMissingWarning 22:55:13 INFO - c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\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. 22:55:13 INFO - InsecurePlatformWarning 22:55:13 INFO - c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\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. 22:55:13 INFO - InsecurePlatformWarning 22:55:13 INFO - Return code: 0 22:55:13 INFO - Installing PyHawk-with-a-single-extra-commit==0.1.5 into virtualenv c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv 22:55:13 INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\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 0x02599C58>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027A1278>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0248EC70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02805B78>, '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 0x02653D70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029341D8>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build', 'env': {'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'USERNAME': 'cltbld', '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', 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'HOSTTYPE': 'i686', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PWD': 'c:/Users/cltbld', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 'CVS_RSH': 'ssh', 'LOGNAME': 'cltbld', 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'SYSTEMROOT': 'C:\\Windows', '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', 'MAKE_MODE': 'unix', 'TERM': 'cygwin', 'SHELL': 'C:/mozilla-build/msys/bin/sh', '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', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'EDITOR': 'emacs.exe', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'OSTYPE': 'msys', 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'SSH_AGENT_PID': '3144', '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-snhTIW4044/agent.4044', 'XPCOM_DEBUG_BREAK': 'stack-and-abort', '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', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'LOGONSERVER': '\\\\B-2008-SPOT-029', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'HOMEPATH': '\\', 'MOZILLABUILD': 'C:\\mozilla-build', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'FP_NO_HOST_CHECK': 'NO', 'WINDIR': 'C:\\Windows', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'OS_VERSION': '2008', 'PROGRAMFILES': 'C:\\Program Files (x86)', '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', 'PROCESSOR_LEVEL': '6', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'USERPROFILE': 'C:\\Users\\cltbld'}}, attempt #1 22:55:13 INFO - Running command: ['c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'PyHawk-with-a-single-extra-commit==0.1.5'] in c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build 22:55:13 INFO - Copy/paste: c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv\Scripts\pip install --timeout 120 PyHawk-with-a-single-extra-commit==0.1.5 22:55:13 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:55:13 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 22:55:13 INFO - 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 22:55:13 INFO - 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 22:55:13 INFO - 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 22:55:13 INFO - 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 22:55:13 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:55:13 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:55:13 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:55:13 INFO - 'COMPUTERNAME': 'B-2008-SPOT-029', 22:55:13 INFO - 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 22:55:13 INFO - 'CVS_RSH': 'ssh', 22:55:13 INFO - 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 22:55:13 INFO - 'EDITOR': 'emacs.exe', 22:55:13 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:55:13 INFO - 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 22:55:13 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 22:55:13 INFO - 'HOME': 'c:/Users/cltbld', 22:55:13 INFO - 'HOMEDRIVE': 'C:', 22:55:13 INFO - 'HOMEPATH': '\\', 22:55:13 INFO - 'HOSTTYPE': 'i686', 22:55:13 INFO - 'IDLEIZER_HALT_ON_IDLE': 'true', 22:55:13 INFO - 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 22:55:13 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 22:55:13 INFO - 'LOG': '"c:\\runner\\buildbot-startup.log"', 22:55:13 INFO - 'LOGNAME': 'cltbld', 22:55:13 INFO - 'LOGONSERVER': '\\\\B-2008-SPOT-029', 22:55:13 INFO - 'MACHTYPE': 'i686-pc-msys', 22:55:13 INFO - 'MAKE_MODE': 'unix', 22:55:13 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build', 22:55:13 INFO - 'MOZILLABUILD': 'C:\\mozilla-build', 22:55:13 INFO - 'MOZ_AUTOMATION': '1', 22:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:13 INFO - 'MOZ_OBJDIR': 'obj-firefox', 22:55:13 INFO - 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 22:55:13 INFO - 'MSYSTEM': 'MINGW32', 22:55:13 INFO - 'NUMBER_OF_PROCESSORS': '16', 22:55:13 INFO - 'OLDPWD': 'c:/Users/cltbld', 22:55:13 INFO - 'OS': 'Windows_NT', 22:55:13 INFO - 'OSTYPE': 'msys', 22:55:13 INFO - 'OS_VERSION': '2008', 22:55:13 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', 22:55:13 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:55:13 INFO - 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 22:55:13 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:55:13 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:55:13 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 22:55:13 INFO - 'PROCESSOR_LEVEL': '6', 22:55:13 INFO - 'PROCESSOR_REVISION': '3e04', 22:55:13 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:55:13 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:55:13 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:55:13 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:55:13 INFO - 'PROMPT': '$P$G', 22:55:13 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\buildprops.json', 22:55:13 INFO - 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 22:55:13 INFO - 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 22:55:13 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:55:13 INFO - 'PWD': 'c:/Users/cltbld', 22:55:13 INFO - 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 22:55:13 INFO - 'SHELL': 'C:/mozilla-build/msys/bin/sh', 22:55:13 INFO - 'SHLVL': '1', 22:55:13 INFO - 'SSH_AGENT_PID': '3144', 22:55:13 INFO - 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-snhTIW4044/agent.4044', 22:55:13 INFO - 'SYSTEMDRIVE': 'C:', 22:55:13 INFO - 'SYSTEMROOT': 'C:\\Windows', 22:55:13 INFO - 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 22:55:13 INFO - 'TERM': 'cygwin', 22:55:13 INFO - 'TINDERBOX_OUTPUT': '1', 22:55:13 INFO - 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 22:55:13 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 22:55:13 INFO - 'TOOLTOOL_HOME': '/c/builds', 22:55:13 INFO - 'USERDOMAIN': 'B-2008-SPOT-029', 22:55:13 INFO - 'USERNAME': 'cltbld', 22:55:13 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 22:55:13 INFO - 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 22:55:13 INFO - 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 22:55:13 INFO - 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 22:55:13 INFO - 'WINDIR': 'C:\\Windows', 22:55:13 INFO - 'WINDOWS_TRACING_FLAGS': '3', 22:55:13 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 22:55:13 INFO - 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 22:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 22:55:13 INFO - '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'} 22:55:14 INFO - Collecting PyHawk-with-a-single-extra-commit==0.1.5 22:55:15 INFO - Using cached PyHawk-with-a-single-extra-commit-0.1.5.tar.gz 22:55:15 INFO - Installing collected packages: PyHawk-with-a-single-extra-commit 22:55:15 INFO - Running setup.py install for PyHawk-with-a-single-extra-commit: started 22:55:15 INFO - Running setup.py install for PyHawk-with-a-single-extra-commit: finished with status 'done' 22:55:15 INFO - Successfully installed PyHawk-with-a-single-extra-commit-0.1.5 22:55:15 INFO - c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\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. 22:55:15 INFO - SNIMissingWarning 22:55:15 INFO - c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\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. 22:55:15 INFO - InsecurePlatformWarning 22:55:15 INFO - Return code: 0 22:55:15 INFO - Installing taskcluster==0.0.26 into virtualenv c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv 22:55:15 INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\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 0x02599C58>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027A1278>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0248EC70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02805B78>, '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 0x02653D70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029341D8>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build', 'env': {'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'USERNAME': 'cltbld', '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', 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'HOSTTYPE': 'i686', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PWD': 'c:/Users/cltbld', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 'CVS_RSH': 'ssh', 'LOGNAME': 'cltbld', 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'SYSTEMROOT': 'C:\\Windows', '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', 'MAKE_MODE': 'unix', 'TERM': 'cygwin', 'SHELL': 'C:/mozilla-build/msys/bin/sh', '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', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'EDITOR': 'emacs.exe', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'OSTYPE': 'msys', 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'SSH_AGENT_PID': '3144', '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-snhTIW4044/agent.4044', 'XPCOM_DEBUG_BREAK': 'stack-and-abort', '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', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'LOGONSERVER': '\\\\B-2008-SPOT-029', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'HOMEPATH': '\\', 'MOZILLABUILD': 'C:\\mozilla-build', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'FP_NO_HOST_CHECK': 'NO', 'WINDIR': 'C:\\Windows', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'OS_VERSION': '2008', 'PROGRAMFILES': 'C:\\Program Files (x86)', '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', 'PROCESSOR_LEVEL': '6', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'USERPROFILE': 'C:\\Users\\cltbld'}}, attempt #1 22:55:15 INFO - Running command: ['c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'taskcluster==0.0.26'] in c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build 22:55:15 INFO - Copy/paste: c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv\Scripts\pip install --timeout 120 taskcluster==0.0.26 22:55:15 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:55:15 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 22:55:15 INFO - 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 22:55:15 INFO - 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 22:55:15 INFO - 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 22:55:15 INFO - 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 22:55:15 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:55:16 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:55:16 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:55:16 INFO - 'COMPUTERNAME': 'B-2008-SPOT-029', 22:55:16 INFO - 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 22:55:16 INFO - 'CVS_RSH': 'ssh', 22:55:16 INFO - 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 22:55:16 INFO - 'EDITOR': 'emacs.exe', 22:55:16 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:55:16 INFO - 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 22:55:16 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 22:55:16 INFO - 'HOME': 'c:/Users/cltbld', 22:55:16 INFO - 'HOMEDRIVE': 'C:', 22:55:16 INFO - 'HOMEPATH': '\\', 22:55:16 INFO - 'HOSTTYPE': 'i686', 22:55:16 INFO - 'IDLEIZER_HALT_ON_IDLE': 'true', 22:55:16 INFO - 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 22:55:16 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 22:55:16 INFO - 'LOG': '"c:\\runner\\buildbot-startup.log"', 22:55:16 INFO - 'LOGNAME': 'cltbld', 22:55:16 INFO - 'LOGONSERVER': '\\\\B-2008-SPOT-029', 22:55:16 INFO - 'MACHTYPE': 'i686-pc-msys', 22:55:16 INFO - 'MAKE_MODE': 'unix', 22:55:16 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build', 22:55:16 INFO - 'MOZILLABUILD': 'C:\\mozilla-build', 22:55:16 INFO - 'MOZ_AUTOMATION': '1', 22:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:16 INFO - 'MOZ_OBJDIR': 'obj-firefox', 22:55:16 INFO - 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 22:55:16 INFO - 'MSYSTEM': 'MINGW32', 22:55:16 INFO - 'NUMBER_OF_PROCESSORS': '16', 22:55:16 INFO - 'OLDPWD': 'c:/Users/cltbld', 22:55:16 INFO - 'OS': 'Windows_NT', 22:55:16 INFO - 'OSTYPE': 'msys', 22:55:16 INFO - 'OS_VERSION': '2008', 22:55:16 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', 22:55:16 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:55:16 INFO - 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 22:55:16 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:55:16 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:55:16 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 62 Stepping 4, GenuineIntel', 22:55:16 INFO - 'PROCESSOR_LEVEL': '6', 22:55:16 INFO - 'PROCESSOR_REVISION': '3e04', 22:55:16 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:55:16 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:55:16 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:55:16 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:55:16 INFO - 'PROMPT': '$P$G', 22:55:16 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\buildprops.json', 22:55:16 INFO - 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 22:55:16 INFO - 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 22:55:16 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:55:16 INFO - 'PWD': 'c:/Users/cltbld', 22:55:16 INFO - 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 22:55:16 INFO - 'SHELL': 'C:/mozilla-build/msys/bin/sh', 22:55:16 INFO - 'SHLVL': '1', 22:55:16 INFO - 'SSH_AGENT_PID': '3144', 22:55:16 INFO - 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-snhTIW4044/agent.4044', 22:55:16 INFO - 'SYSTEMDRIVE': 'C:', 22:55:16 INFO - 'SYSTEMROOT': 'C:\\Windows', 22:55:16 INFO - 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 22:55:16 INFO - 'TERM': 'cygwin', 22:55:16 INFO - 'TINDERBOX_OUTPUT': '1', 22:55:16 INFO - 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 22:55:16 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 22:55:16 INFO - 'TOOLTOOL_HOME': '/c/builds', 22:55:16 INFO - 'USERDOMAIN': 'B-2008-SPOT-029', 22:55:16 INFO - 'USERNAME': 'cltbld', 22:55:16 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 22:55:16 INFO - 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 22:55:16 INFO - 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 22:55:16 INFO - 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 22:55:16 INFO - 'WINDIR': 'C:\\Windows', 22:55:16 INFO - 'WINDOWS_TRACING_FLAGS': '3', 22:55:16 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 22:55:16 INFO - 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 22:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 22:55:16 INFO - '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'} 22:55:16 INFO - Collecting taskcluster==0.0.26 22:55:17 INFO - Using cached taskcluster-0.0.26.tar.gz 22:55:17 INFO - Collecting requests<=2.7.0,>=2.4.3 (from taskcluster==0.0.26) 22:55:17 INFO - Using cached requests-2.7.0-py2.py3-none-any.whl 22:55:17 INFO - Requirement already satisfied: PyHawk_with_a_single_extra_commit==0.1.5 in .\venv\lib\site-packages (from taskcluster==0.0.26) 22:55:17 INFO - Collecting slugid (from taskcluster==0.0.26) 22:55:17 INFO - Using cached slugid-1.0.7.tar.gz 22:55:17 INFO - Installing collected packages: requests, slugid, taskcluster 22:55:17 INFO - Found existing installation: requests 2.8.1 22:55:18 INFO - Uninstalling requests-2.8.1: 22:55:18 INFO - Successfully uninstalled requests-2.8.1 22:55:20 INFO - Running setup.py install for slugid: started 22:55:20 INFO - Running setup.py install for slugid: finished with status 'done' 22:55:20 INFO - Running setup.py install for taskcluster: started 22:55:20 INFO - Running setup.py install for taskcluster: finished with status 'done' 22:55:21 INFO - Successfully installed requests-2.7.0 slugid-1.0.7 taskcluster-0.0.26 22:55:21 INFO - c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\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. 22:55:21 INFO - SNIMissingWarning 22:55:21 INFO - c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\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. 22:55:21 INFO - InsecurePlatformWarning 22:55:21 INFO - Return code: 0 22:55:21 INFO - Done creating virtualenv c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv. 22:55:21 INFO - Getting output from command: ['c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\venv\\Scripts\\pip', 'freeze'] 22:55:21 INFO - Copy/paste: c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\venv\Scripts\pip freeze 22:55:22 INFO - Reading from file tmpfile_stdout 22:55:22 INFO - Using _rmtree_windows ... 22:55:22 INFO - Using _rmtree_windows ... 22:55:22 INFO - Current package versions: 22:55:22 INFO - PyHawk-with-a-single-extra-commit == 0.1.5 22:55:22 INFO - requests == 2.7.0 22:55:22 INFO - slugid == 1.0.7 22:55:22 INFO - taskcluster == 0.0.26 22:55:22 INFO - Dumping config to c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\logs\localconfig.json. 22:55:22 INFO - {'app_ini_path': '%(obj_dir)s/dist/bin/application.ini', 22:55:22 INFO - 'append_to_log': False, 22:55:22 INFO - 'balrog_credentials_file': 'oauth.txt', 22:55:22 INFO - 'balrog_servers': ({'balrog_api_root': 'https://aus4-admin.mozilla.org/api', 22:55:22 INFO - 'balrog_usernames': {'Fennec': 'ffxbld', 22:55:22 INFO - 'firefox': 'ffxbld', 22:55:22 INFO - 'mobile': 'ffxbld', 22:55:22 INFO - 'thunderbird': 'tbirdbld'}, 22:55:22 INFO - 'ignore_failures': False, 22:55:22 INFO - 'url_replacements': (('http://archive.mozilla.org/pub', 22:55:22 INFO - 'http://download.cdn.mozilla.net/pub'),)},), 22:55:22 INFO - 'base_name': 'WINNT_6.1_x86-64_%(branch)s', 22:55:22 INFO - 'base_work_dir': 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000', 22:55:22 INFO - 'branch': 'mozilla-beta', 22:55:22 INFO - 'branch_uses_per_checkin_strategy': True, 22:55:22 INFO - 'build_pool': 'production', 22:55:22 INFO - 'build_resources_path': '%(abs_src_dir)s/obj-firefox/.mozbuild/build_resources.json', 22:55:22 INFO - 'build_type': 'add-on-devel', 22:55:22 INFO - 'build_variant': 'add-on-devel', 22:55:22 INFO - 'buildbot_json_path': 'buildprops.json', 22:55:22 INFO - 'check_test_env': {'MINIDUMP_SAVE_PATH': '%(base_work_dir)s/minidumps', 22:55:22 INFO - 'MINIDUMP_STACKWALK': '%(abs_tools_dir)s/breakpad/win64/minidump_stackwalk.exe'}, 22:55:22 INFO - 'clobberer_url': 'https://api.pub.build.mozilla.org/clobberer/lastclobber', 22:55:22 INFO - 'clone_by_revision': False, 22:55:22 INFO - 'clone_with_purge': False, 22:55:22 INFO - 'config_files': ('builds/releng_base_windows_64_builds.py', 22:55:22 INFO - 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\scripts\\scripts\\..\\configs\\builds/releng_sub_windows_configs/64_add-on-devel.py', 22:55:22 INFO - 'balrog/production.py', 22:55:22 INFO - 'builds/branch_specifics.py', 22:55:22 INFO - 'builds/build_pool_specifics.py'), 22:55:22 INFO - 'debug_build': False, 22:55:22 INFO - 'default_actions': ('clobber', 22:55:22 INFO - 'clone-tools', 22:55:22 INFO - 'checkout-sources', 22:55:22 INFO - 'build', 22:55:22 INFO - 'upload-files', 22:55:22 INFO - 'check-test'), 22:55:22 INFO - 'enable_ccache': False, 22:55:22 INFO - 'enable_count_ctors': False, 22:55:22 INFO - 'enable_pymake': True, 22:55:22 INFO - 'enable_release_promotion': 1, 22:55:22 INFO - 'enable_signing': True, 22:55:22 INFO - 'enable_talos_sendchange': False, 22:55:22 INFO - 'enable_unittest_sendchange': True, 22:55:22 INFO - 'env': {'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 22:55:22 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 22:55:22 INFO - 'MOZ_AUTOMATION': '1', 22:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:22 INFO - 'MOZ_OBJDIR': 'obj-firefox', 22:55:22 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', 22:55:22 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\buildprops.json', 22:55:22 INFO - 'TINDERBOX_OUTPUT': '1', 22:55:22 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 22:55:22 INFO - 'TOOLTOOL_HOME': '/c/builds', 22:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'stack-and-abort'}, 22:55:22 INFO - 'exes': {'buildbot': ('c:\\mozilla-build\\python27\\python.exe', 22:55:22 INFO - 'c:\\mozilla-build\\buildbotve\\scripts\\buildbot'), 22:55:22 INFO - 'make': ('c:\\mozilla-build\\python27\\python.exe', 22:55:22 INFO - 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\build\\pymake\\make.py'), 22:55:22 INFO - 'python2.7': 'c:\\mozilla-build\\python27\\python.exe', 22:55:22 INFO - 'virtualenv': ('c:\\mozilla-build\\python27\\python.exe', 22:55:22 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 22:55:22 INFO - 'graph_selector': '/server/collect.cgi', 22:55:22 INFO - 'graph_server': 'graphs.mozilla.org', 22:55:22 INFO - 'include_post_upload_builddir': False, 22:55:22 INFO - 'is_automation': True, 22:55:22 INFO - 'latest_mar_dir': '/pub/mozilla.org/firefox/nightly/latest-%(branch)s', 22:55:22 INFO - 'log_level': 'info', 22:55:22 INFO - 'log_to_console': True, 22:55:22 INFO - 'max_build_output_timeout': 4800, 22:55:22 INFO - 'nightly_build': False, 22:55:22 INFO - 'nightly_promotion_branches': ('mozilla-central', 'mozilla-aurora'), 22:55:22 INFO - 'objdir': 'obj-firefox', 22:55:22 INFO - 'old_packages': ('%(objdir)s/dist/firefox-*', 22:55:22 INFO - '%(objdir)s/dist/fennec*', 22:55:22 INFO - '%(objdir)s/dist/seamonkey*', 22:55:22 INFO - '%(objdir)s/dist/thunderbird*', 22:55:22 INFO - '%(objdir)s/dist/install/sea/*.exe'), 22:55:22 INFO - 'opt_config_files': (), 22:55:22 INFO - 'periodic_clobber': 168, 22:55:22 INFO - 'pgo_build': False, 22:55:22 INFO - 'pgo_platforms': ('linux', 'linux64', 'win32', 'win64'), 22:55:22 INFO - 'platform': 'win64', 22:55:22 INFO - 'platform_overrides': {'linux': {'force_clobber': True, 22:55:22 INFO - 'src_mozconfig': 'browser/config/mozconfigs/linux32/beta'}, 22:55:22 INFO - 'linux-debug': {'update_channel': 'default'}, 22:55:22 INFO - 'linux64': {'force_clobber': True, 22:55:22 INFO - 'src_mozconfig': 'browser/config/mozconfigs/linux64/beta'}, 22:55:22 INFO - 'linux64-add-on-devel': {'update_channel': 'default'}, 22:55:22 INFO - 'linux64-asan': {'update_channel': 'default'}, 22:55:22 INFO - 'linux64-asan-debug': {'update_channel': 'default'}, 22:55:22 INFO - 'linux64-cc': {'update_channel': 'default'}, 22:55:22 INFO - 'linux64-debug': {'update_channel': 'default'}, 22:55:22 INFO - 'linux64-st-an': {'update_channel': 'default'}, 22:55:22 INFO - 'linux64-st-an-debug': {'update_channel': 'default'}, 22:55:22 INFO - 'linux64-tsan': {'update_channel': 'default'}, 22:55:22 INFO - 'macosx64': {'force_clobber': True, 22:55:22 INFO - 'src_mozconfig': 'browser/config/mozconfigs/macosx-universal/beta'}, 22:55:22 INFO - 'macosx64-add-on-devel': {'update_channel': 'default'}, 22:55:22 INFO - 'macosx64-debug': {'update_channel': 'default'}, 22:55:22 INFO - 'macosx64-st-an': {'update_channel': 'default'}, 22:55:22 INFO - 'macosx64-st-an-debug': {'update_channel': 'default'}, 22:55:22 INFO - 'win32': {'force_clobber': True, 22:55:22 INFO - 'src_mozconfig': 'browser/config/mozconfigs/win32/beta'}, 22:55:22 INFO - 'win32-add-on-devel': {'update_channel': 'default'}, 22:55:22 INFO - 'win32-debug': {'update_channel': 'default'}, 22:55:22 INFO - 'win64': {'force_clobber': True, 22:55:22 INFO - 'src_mozconfig': 'browser/config/mozconfigs/win64/beta'}, 22:55:22 INFO - 'win64-add-on-devel': {'update_channel': 'default'}, 22:55:22 INFO - 'win64-debug': {'update_channel': 'default'}}, 22:55:22 INFO - 'platform_supports_post_upload_to_latest': True, 22:55:22 INFO - 'publish_nightly_en_US_routes': True, 22:55:22 INFO - 'release_to_try_builds': False, 22:55:22 INFO - 'repo_base': 'https://hg.mozilla.org', 22:55:22 INFO - 'repo_path': 'releases/mozilla-beta', 22:55:22 INFO - 'scm_level': 1, 22:55:22 INFO - 'sendchange_masters': ('buildbot-master81.build.mozilla.org:9301',), 22:55:22 INFO - 'src_mozconfig': 'browser/config/mozconfigs/win64/add-on-devel', 22:55:22 INFO - 'stage_platform': 'win64-add-on-devel', 22:55:22 INFO - 'stage_product': 'firefox', 22:55:22 INFO - 'stage_server': 'upload.ffxbld.productdelivery.prod.mozaws.net', 22:55:22 INFO - 'stage_ssh_key': 'ffxbld_rsa', 22:55:22 INFO - 'stage_username': 'ffxbld', 22:55:22 INFO - 'taskcluster_credentials_file': 'oauth.txt', 22:55:22 INFO - 'taskcluster_index': 'index', 22:55:22 INFO - 'tinderbox_build_dir': None, 22:55:22 INFO - 'to_tinderbox_dated': True, 22:55:22 INFO - 'tools_repo': 'https://hg.mozilla.org/build/tools', 22:55:22 INFO - 'tooltool_bootstrap': 'setup.sh', 22:55:22 INFO - 'tooltool_manifest_src': 'browser/config/tooltool-manifests/win64/releng.manifest', 22:55:22 INFO - 'tooltool_script': ('c:\\mozilla-build\\python27\\python.exe', 22:55:22 INFO - 'C:/mozilla-build/tooltool.py'), 22:55:22 INFO - 'tooltool_url': 'https://api.pub.build.mozilla.org/tooltool/', 22:55:22 INFO - 'update_channel': 'default', 22:55:22 INFO - 'upload_env': {'UPLOAD_HOST': '%(stage_server)s', 22:55:22 INFO - 'UPLOAD_SSH_KEY': '/c/Users/cltbld/.ssh/%(stage_ssh_key)s', 22:55:22 INFO - 'UPLOAD_TO_TEMP': '1', 22:55:22 INFO - 'UPLOAD_USER': '%(stage_username)s'}, 22:55:22 INFO - 'use_clobberer': True, 22:55:22 INFO - 'vcs_share_base': 'C:/builds/hg-shared', 22:55:22 INFO - 'virtualenv_modules': ('requests==2.8.1', 22:55:22 INFO - 'PyHawk-with-a-single-extra-commit==0.1.5', 22:55:22 INFO - 'taskcluster==0.0.26'), 22:55:22 INFO - 'virtualenv_path': 'venv', 22:55:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:55:22 INFO - 'who': '', 22:55:22 INFO - 'work_dir': 'build'} 22:55:22 INFO - [mozharness: 2017-01-24 06:55:22.126000Z] Skipping get-secrets step. 22:55:22 INFO - [mozharness: 2017-01-24 06:55:22.126000Z] Running clobber step. 22:55:22 INFO - Running main action method: clobber 22:55:22 INFO - retry: Calling run_command with args: [['python', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\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'mozilla-beta', u'WINNT 6.1 x86-64 add-on-devel mozilla-beta build', 'm-beta-w64-add-on-devel-000000', 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 22:55:22 INFO - Running command: ['python', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\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'mozilla-beta', u'WINNT 6.1 x86-64 add-on-devel mozilla-beta build', 'm-beta-w64-add-on-devel-000000', u'b-2008-spot-029', u'http://buildbot-master94.bb.releng.use1.mozilla.com:8001/'] in c:\builds\moz2_slave 22:55:22 INFO - Copy/paste: python c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\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 mozilla-beta "WINNT 6.1 x86-64 add-on-devel mozilla-beta build" m-beta-w64-add-on-devel-000000 b-2008-spot-029 http://buildbot-master94.bb.releng.use1.mozilla.com:8001/ 22:55:22 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=m-beta-w64-add-on-devel-000000&branch=mozilla-beta&buildername=WINNT+6.1+x86-64+add-on-devel+mozilla-beta+build 22:55:22 INFO - m-beta-w64-add-on-devel-000000:Our last clobber date: None 22:55:22 INFO - m-beta-w64-add-on-devel-000000:Server clobber date: None 22:55:22 INFO - TinderboxPrint: purged clobber 22:55:22 INFO - Return code: 0 22:55:22 INFO - [mozharness: 2017-01-24 06:55:22.754000Z] Finished clobber step (success) 22:55:22 INFO - [mozharness: 2017-01-24 06:55:22.755000Z] Running clone-tools step. 22:55:22 INFO - Running main action method: clone_tools 22:55:22 INFO - retry: Calling _get_revision with args: (, 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\tools'), kwargs: {}, attempt #1 22:55:22 WARNING - did not specify revision or branch; assuming "default" 22:55:22 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version'] 22:55:22 INFO - Copy/paste: hg --config ui.merge=internal:merge --version 22:55:24 INFO - Mercurial Distributed SCM (version 3.9.1) 22:55:24 INFO - (see https://mercurial-scm.org for more information) 22:55:24 INFO - Copyright (C) 2005-2016 Matt Mackall and others 22:55:24 INFO - This is free software; see the source for copying conditions. There is NO 22:55:24 INFO - warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. 22:55:24 INFO - Return code: 0 22:55:24 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall'] 22:55:24 INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall 22:55:24 INFO - checking encoding (cp1252)... 22:55:24 INFO - checking Python executable (c:\mozilla-build\hg\hg.exe) 22:55:24 INFO - checking Python version (2.7.12) 22:55:24 INFO - checking Python lib (c:\mozilla-build\hg\lib\library.zip)... 22:55:24 INFO - checking Mercurial version (3.9.1) 22:55:24 INFO - checking Mercurial custom build () 22:55:24 INFO - checking module policy (c) 22:55:24 INFO - checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)... 22:55:24 INFO - checking templates (c:\mozilla-build\hg\templates)... 22:55:24 INFO - checking default template (c:\mozilla-build\hg\templates\map-cmdline.default) 22:55:24 INFO - checking commit editor... (notepad) 22:55:24 INFO - checking username (Mozilla Release Engineering ) 22:55:24 INFO - no problems detected 22:55:24 INFO - Return code: 0 22:55:24 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/build/tools', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\tools', '--sharebase', 'C:/builds/hg-shared', '--branch', 'default'] 22:55:24 INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/build/tools c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\tools --sharebase C:/builds/hg-shared --branch default 22:55:26 INFO - ensuring https://hg.mozilla.org/build/tools@default is available at c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\tools 22:55:26 INFO - (sharing from existing pooled repository 7ae7fb134bf7aec6ec96a062ff47a69053dd2973) 22:55:26 INFO - searching for changes 22:55:26 INFO - no changes found 22:55:26 INFO - (pulling to obtain default) 22:55:26 INFO - (remote resolved default to 5fffbd76a4bf50ff45960cf36add7d196261c242; result is not deterministic) 22:55:26 INFO - (revision already present locally; not pulling) 22:55:30 INFO - 22:55:30 INFO - updating [===================================================> ] 900/936 01s 22:55:30 INFO - 22:55:30 INFO - 936 files updated, 0 files merged, 0 files removed, 0 files unresolved 22:55:30 INFO - updated to 5fffbd76a4bf50ff45960cf36add7d196261c242 22:55:30 INFO - Return code: 0 22:55:30 INFO - [mozharness: 2017-01-24 06:55:30.722000Z] Finished clone-tools step (success) 22:55:30 INFO - [mozharness: 2017-01-24 06:55:30.722000Z] Running checkout-sources step. 22:55:30 INFO - Running main action method: checkout_sources 22:55:30 WARNING - signing disabled because MOZ_SIGNING_SERVERS is not set 22:55:30 INFO - Release promotion update channel: default 22:55:30 INFO - retry: Calling _get_revision with args: (, 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src'), kwargs: {}, attempt #1 22:55:30 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version'] 22:55:30 INFO - Copy/paste: hg --config ui.merge=internal:merge --version 22:55:30 INFO - Mercurial Distributed SCM (version 3.9.1) 22:55:30 INFO - (see https://mercurial-scm.org for more information) 22:55:30 INFO - Copyright (C) 2005-2016 Matt Mackall and others 22:55:30 INFO - This is free software; see the source for copying conditions. There is NO 22:55:30 INFO - warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. 22:55:30 INFO - Return code: 0 22:55:30 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall'] 22:55:30 INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall 22:55:31 INFO - checking encoding (cp1252)... 22:55:31 INFO - checking Python executable (c:\mozilla-build\hg\hg.exe) 22:55:31 INFO - checking Python version (2.7.12) 22:55:31 INFO - checking Python lib (c:\mozilla-build\hg\lib\library.zip)... 22:55:31 INFO - checking Mercurial version (3.9.1) 22:55:31 INFO - checking Mercurial custom build () 22:55:31 INFO - checking module policy (c) 22:55:31 INFO - checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)... 22:55:31 INFO - checking templates (c:\mozilla-build\hg\templates)... 22:55:31 INFO - checking default template (c:\mozilla-build\hg\templates\map-cmdline.default) 22:55:31 INFO - checking commit editor... (notepad) 22:55:31 INFO - checking username (Mozilla Release Engineering ) 22:55:31 INFO - no problems detected 22:55:31 INFO - Return code: 0 22:55:31 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/releases/mozilla-beta', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src', '--sharebase', 'C:/builds/hg-shared', '--revision', '1522cb56a651b62675f392d4064bd4365aac07f4'] 22:55:31 INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/releases/mozilla-beta c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src --sharebase C:/builds/hg-shared --revision 1522cb56a651b62675f392d4064bd4365aac07f4 23:01:10 INFO - 23:01:10 INFO - changesets [ ] 1/44219 23:01:10 INFO - changesets [====> ] 4399/44219 23:01:10 INFO - changesets [========> ] 8109/44219 23:01:10 INFO - changesets [===========> ] 11150/44219 09s 23:01:10 INFO - changesets [==============> ] 13812/44219 09s 23:01:10 INFO - changesets [================> ] 16130/44219 09s 23:01:10 INFO - changesets [==================> ] 17503/44219 10s 23:01:10 INFO - changesets [===================> ] 18721/44219 10s 23:01:10 INFO - changesets [=====================> ] 19894/44219 10s 23:01:10 INFO - changesets [======================> ] 21007/44219 10s 23:01:10 INFO - changesets [=======================> ] 22083/44219 11s 23:01:10 INFO - changesets [========================> ] 23116/44219 11s 23:01:10 INFO - changesets [=========================> ] 24112/44219 11s 23:01:10 INFO - changesets [==========================> ] 25083/44219 10s 23:01:10 INFO - changesets [===========================> ] 26039/44219 10s 23:01:10 INFO - changesets [============================> ] 26960/44219 10s 23:01:10 INFO - changesets [=============================> ] 27851/44219 10s 23:01:10 INFO - changesets [==============================> ] 28728/44219 10s 23:01:10 INFO - changesets [===============================> ] 29583/44219 09s 23:01:10 INFO - changesets [================================> ] 30416/44219 09s 23:01:10 INFO - changesets [=================================> ] 31232/44219 09s 23:01:10 INFO - changesets [==================================> ] 32029/44219 08s 23:01:10 INFO - changesets [===================================> ] 32817/44219 08s 23:01:10 INFO - changesets [====================================> ] 33560/44219 08s 23:01:10 INFO - changesets [=====================================> ] 34301/44219 07s 23:01:10 INFO - changesets [=====================================> ] 35023/44219 07s 23:01:10 INFO - changesets [======================================> ] 35736/44219 07s 23:01:10 INFO - changesets [=======================================> ] 36441/44219 06s 23:01:10 INFO - changesets [========================================> ] 37133/44219 06s 23:01:10 INFO - changesets [========================================> ] 37818/44219 05s 23:01:10 INFO - changesets [=========================================> ] 38494/44219 05s 23:01:10 INFO - changesets [==========================================> ] 39155/44219 05s 23:01:10 INFO - changesets [===========================================> ] 39812/44219 04s 23:01:10 INFO - changesets [===========================================> ] 40455/44219 04s 23:01:10 INFO - changesets [============================================> ] 41090/44219 03s 23:01:10 INFO - changesets [=============================================> ] 41716/44219 03s 23:01:10 INFO - changesets [=============================================> ] 42338/44219 02s 23:01:10 INFO - changesets [==============================================> ] 42947/44219 02s 23:01:10 INFO - changesets [===============================================> ] 43540/44219 01s 23:01:10 INFO - changesets [===============================================> ] 44140/44219 01s 23:01:10 INFO - 23:01:10 INFO - 23:01:10 INFO - manifests [> ] 1054/44219 1m30s 23:01:10 INFO - manifests [=> ] 2433/44219 56s 23:01:10 INFO - manifests [==> ] 2862/44219 1m07s 23:01:10 INFO - manifests [===> ] 4217/44219 53s 23:01:10 INFO - manifests [=====> ] 5420/44219 50s 23:01:10 INFO - manifests [=======> ] 7834/44219 38s 23:01:10 INFO - manifests [==========> ] 9734/44219 33s 23:01:10 INFO - manifests [===========> ] 10770/44219 32s 23:01:10 INFO - manifests [============> ] 11757/44219 32s 23:01:10 INFO - manifests [=============> ] 12674/44219 33s 23:01:10 INFO - manifests [===============> ] 14299/44219 31s 23:01:10 INFO - manifests [===============> ] 14304/44219 33s 23:01:10 INFO - manifests [===============> ] 14311/44219 36s 23:01:10 INFO - manifests [===============> ] 14325/44219 38s 23:01:10 INFO - manifests [===============> ] 14328/44219 41s 23:01:10 INFO - manifests [===============> ] 14335/44219 43s 23:01:10 INFO - manifests [===============> ] 14341/44219 46s 23:01:10 INFO - manifests [===============> ] 14345/44219 49s 23:01:10 INFO - manifests [===============> ] 14351/44219 51s 23:01:10 INFO - manifests [===============> ] 14357/44219 54s 23:01:10 INFO - manifests [===============> ] 14370/44219 57s 23:01:10 INFO - manifests [==============> ] 14380/44219 1m00s 23:01:10 INFO - manifests [==============> ] 14384/44219 1m02s 23:01:10 INFO - manifests [==============> ] 14396/44219 1m05s 23:01:10 INFO - manifests [==============> ] 14408/44219 1m08s 23:01:10 INFO - manifests [==============> ] 14412/44219 1m11s 23:01:10 INFO - manifests [==============> ] 14418/44219 1m14s 23:01:10 INFO - manifests [==============> ] 14427/44219 1m16s 23:01:10 INFO - manifests [==============> ] 14435/44219 1m19s 23:01:10 INFO - manifests [==============> ] 14440/44219 1m22s 23:01:10 INFO - manifests [==============> ] 14443/44219 1m25s 23:01:10 INFO - manifests [==============> ] 14446/44219 1m28s 23:01:10 INFO - manifests [=================> ] 16881/44219 1m11s 23:01:10 INFO - manifests [===================> ] 18868/44219 1m01s 23:01:10 INFO - manifests [=======================> ] 21229/44219 51s 23:01:10 INFO - manifests [========================> ] 22807/44219 45s 23:01:10 INFO - manifests [=========================> ] 23782/44219 42s 23:01:10 INFO - manifests [==========================> ] 24661/44219 40s 23:01:10 INFO - manifests [============================> ] 25929/44219 36s 23:01:10 INFO - manifests [=============================> ] 27190/44219 33s 23:01:10 INFO - manifests [==============================> ] 27715/44219 33s 23:01:10 INFO - manifests [================================> ] 29607/44219 28s 23:01:10 INFO - manifests [==================================> ] 31397/44219 24s 23:01:10 INFO - manifests [===================================> ] 32166/44219 22s 23:01:10 INFO - manifests [====================================> ] 32882/44219 21s 23:01:10 INFO - manifests [=====================================> ] 33882/44219 19s 23:01:10 INFO - manifests [======================================> ] 35069/44219 17s 23:01:10 INFO - manifests [=======================================> ] 36230/44219 14s 23:01:10 INFO - manifests [=========================================> ] 37338/44219 12s 23:01:10 INFO - manifests [===========================================> ] 39606/44219 08s 23:01:10 INFO - manifests [=============================================> ] 41153/44219 06s 23:01:10 INFO - 23:01:10 INFO - 23:01:10 INFO - files [ ] 129/41661 10m57s 23:01:10 INFO - files [ ] 208/41661 10m13s 23:01:10 INFO - files [ ] 542/41661 5m09s 23:01:10 INFO - files [ ] 624/41661 5m41s 23:01:10 INFO - files [ ] 645/41661 6m38s 23:01:10 INFO - files [ ] 671/41661 7m28s 23:01:10 INFO - files [ ] 741/41661 7m55s 23:01:10 INFO - files [> ] 805/41661 8m15s 23:01:10 INFO - files [> ] 813/41661 9m23s 23:01:10 INFO - files [> ] 843/41661 9m52s 23:01:10 INFO - files [> ] 870/41661 10m25s 23:01:10 INFO - files [> ] 1083/41661 8m57s 23:01:10 INFO - files [> ] 1357/41661 7m41s 23:01:10 INFO - files [> ] 1427/41661 7m47s 23:01:10 INFO - files [> ] 1470/41661 8m01s 23:01:10 INFO - files [> ] 1529/41661 8m09s 23:01:10 INFO - files [=> ] 1628/41661 8m03s 23:01:10 INFO - files [=> ] 1740/41661 7m54s 23:01:10 INFO - files [=> ] 1833/41661 7m51s 23:01:10 INFO - files [=> ] 1900/41661 7m54s 23:01:10 INFO - files [=> ] 2040/41661 7m42s 23:01:10 INFO - files [=> ] 2136/41661 7m40s 23:01:10 INFO - files [=> ] 2297/41661 7m23s 23:01:10 INFO - files [==> ] 2489/41661 7m02s 23:01:10 INFO - files [==> ] 2715/41661 6m40s 23:01:10 INFO - files [==> ] 2914/41661 6m24s 23:01:10 INFO - files [==> ] 3154/41661 6m06s 23:01:10 INFO - files [===> ] 3369/41661 5m52s 23:01:10 INFO - files [===> ] 3624/41661 5m36s 23:01:10 INFO - files [===> ] 3742/41661 5m34s 23:01:10 INFO - files [===> ] 3910/41661 5m29s 23:01:10 INFO - files [====> ] 4080/41661 5m23s 23:01:10 INFO - files [====> ] 4136/41661 5m30s 23:01:10 INFO - files [====> ] 4268/41661 5m27s 23:01:10 INFO - files [====> ] 4461/41661 5m20s 23:01:10 INFO - files [====> ] 4593/41661 5m18s 23:01:10 INFO - files [====> ] 4662/41661 5m21s 23:01:10 INFO - files [====> ] 4697/41661 5m26s 23:01:10 INFO - files [====> ] 4764/41661 5m29s 23:01:10 INFO - files [=====> ] 4875/41661 5m28s 23:01:10 INFO - files [=====> ] 5022/41661 5m25s 23:01:10 INFO - files [=====> ] 5127/41661 5m24s 23:01:10 INFO - files [=====> ] 5211/41661 5m25s 23:01:10 INFO - files [=====> ] 5290/41661 5m27s 23:01:10 INFO - files [=====> ] 5370/41661 5m29s 23:01:10 INFO - files [=====> ] 5407/41661 5m37s 23:01:10 INFO - files [=====> ] 5450/41661 5m41s 23:01:10 INFO - files [=====> ] 5478/41661 5m46s 23:01:10 INFO - files [=====> ] 5495/41661 5m51s 23:01:10 INFO - files [=====> ] 5507/41661 5m57s 23:01:10 INFO - files [=====> ] 5537/41661 6m03s 23:01:10 INFO - files [======> ] 5717/41661 5m58s 23:01:10 INFO - files [======> ] 5793/41661 5m58s 23:01:10 INFO - files [======> ] 5859/41661 6m00s 23:01:10 INFO - files [======> ] 5900/41661 6m03s 23:01:10 INFO - files [======> ] 5999/41661 6m02s 23:01:10 INFO - files [======> ] 6052/41661 6m05s 23:01:10 INFO - files [======> ] 6162/41661 6m03s 23:01:10 INFO - files [======> ] 6305/41661 5m59s 23:01:10 INFO - files [=======> ] 6448/41661 5m55s 23:01:10 INFO - files [=======> ] 6561/41661 5m54s 23:01:10 INFO - files [=======> ] 6638/41661 5m54s 23:01:10 INFO - files [=======> ] 6822/41661 5m48s 23:01:10 INFO - files [=======> ] 7187/41661 5m32s 23:01:10 INFO - files [========> ] 7417/41661 5m24s 23:01:10 INFO - files [========> ] 7559/41661 5m21s 23:01:10 INFO - files [========> ] 7563/41661 5m27s 23:01:10 INFO - files [========> ] 7741/41661 5m22s 23:01:10 INFO - files [========> ] 7833/41661 5m22s 23:01:10 INFO - files [========> ] 7917/41661 5m23s 23:01:10 INFO - files [========> ] 7938/41661 5m27s 23:01:10 INFO - files [========> ] 7958/41661 5m35s 23:01:10 INFO - files [========> ] 7994/41661 5m38s 23:01:10 INFO - files [=========> ] 8051/41661 5m39s 23:01:10 INFO - files [=========> ] 8173/41661 5m39s 23:01:10 INFO - files [=========> ] 8256/41661 5m39s 23:01:10 INFO - files [=========> ] 8336/41661 5m39s 23:01:10 INFO - files [=========> ] 8522/41661 5m34s 23:01:10 INFO - files [=========> ] 8596/41661 5m34s 23:01:10 INFO - files [=========> ] 8657/41661 5m35s 23:01:10 INFO - files [=========> ] 8808/41661 5m32s 23:01:10 INFO - files [==========> ] 8939/41661 5m29s 23:01:10 INFO - files [==========> ] 9112/41661 5m25s 23:01:10 INFO - files [==========> ] 9187/41661 5m25s 23:01:10 INFO - files [==========> ] 9449/41661 5m17s 23:01:10 INFO - files [==========> ] 9590/41661 5m14s 23:01:10 INFO - files [===========> ] 9655/41661 5m15s 23:01:10 INFO - files [===========> ] 9928/41661 5m07s 23:01:10 INFO - files [===========> ] 9956/41661 5m10s 23:01:10 INFO - files [===========> ] 9992/41661 5m11s 23:01:10 INFO - files [===========> ] 10051/41661 5m12s 23:01:10 INFO - files [===========> ] 10076/41661 5m15s 23:01:10 INFO - files [===========> ] 10298/41661 5m09s 23:01:10 INFO - files [===========> ] 10412/41661 5m07s 23:01:10 INFO - files [============> ] 10499/41661 5m07s 23:01:10 INFO - files [============> ] 10635/41661 5m05s 23:01:10 INFO - files [============> ] 10859/41661 4m59s 23:01:10 INFO - files [============> ] 10998/41661 4m57s 23:01:10 INFO - files [============> ] 11180/41661 4m53s 23:01:10 INFO - files [=============> ] 11258/41661 4m54s 23:01:10 INFO - files [=============> ] 11300/41661 4m55s 23:01:10 INFO - files [=============> ] 11536/41661 4m50s 23:01:10 INFO - files [=============> ] 11733/41661 4m46s 23:01:10 INFO - files [=============> ] 11933/41661 4m42s 23:01:10 INFO - files [==============> ] 12117/41661 4m38s 23:01:10 INFO - files [==============> ] 12464/41661 4m30s 23:01:10 INFO - files [==============> ] 12564/41661 4m29s 23:01:10 INFO - files [==============> ] 12603/41661 4m31s 23:01:10 INFO - files [==============> ] 12761/41661 4m28s 23:01:10 INFO - files [===============> ] 12951/41661 4m25s 23:01:10 INFO - files [===============> ] 12988/41661 4m26s 23:01:10 INFO - files [===============> ] 13061/41661 4m26s 23:01:10 INFO - files [===============> ] 13162/41661 4m25s 23:01:10 INFO - files [===============> ] 13250/41661 4m25s 23:01:10 INFO - files [===============> ] 13325/41661 4m25s 23:01:10 INFO - files [===============> ] 13528/41661 4m21s 23:01:10 INFO - files [================> ] 13786/41661 4m16s 23:01:10 INFO - files [================> ] 14018/41661 4m12s 23:01:10 INFO - files [================> ] 14173/41661 4m10s 23:01:10 INFO - files [================> ] 14204/41661 4m11s 23:01:10 INFO - files [================> ] 14242/41661 4m12s 23:01:10 INFO - files [================> ] 14375/41661 4m10s 23:01:10 INFO - files [=================> ] 14463/41661 4m10s 23:01:10 INFO - files [=================> ] 14494/41661 4m11s 23:01:10 INFO - files [=================> ] 14585/41661 4m10s 23:01:10 INFO - files [=================> ] 14622/41661 4m11s 23:01:10 INFO - files [=================> ] 14661/41661 4m12s 23:01:10 INFO - files [=================> ] 14698/41661 4m13s 23:01:10 INFO - files [=================> ] 14745/41661 4m14s 23:01:10 INFO - files [=================> ] 14790/41661 4m15s 23:01:10 INFO - files [=================> ] 14875/41661 4m14s 23:01:10 INFO - files [=================> ] 14956/41661 4m14s 23:01:10 INFO - files [=================> ] 14983/41661 4m15s 23:01:10 INFO - files [=================> ] 15006/41661 4m16s 23:01:10 INFO - files [=================> ] 15037/41661 4m17s 23:01:10 INFO - files [=================> ] 15131/41661 4m17s 23:01:10 INFO - files [=================> ] 15193/41661 4m17s 23:01:10 INFO - files [==================> ] 15263/41661 4m17s 23:01:10 INFO - files [==================> ] 15486/41661 4m13s 23:01:10 INFO - files [==================> ] 15634/41661 4m11s 23:01:10 INFO - files [==================> ] 15783/41661 4m09s 23:01:10 INFO - files [==================> ] 15822/41661 4m09s 23:01:10 INFO - files [==================> ] 15857/41661 4m10s 23:01:10 INFO - files [==================> ] 15891/41661 4m11s 23:01:10 INFO - files [==================> ] 15953/41661 4m11s 23:01:10 INFO - files [==================> ] 15967/41661 4m13s 23:01:10 INFO - files [==================> ] 15986/41661 4m14s 23:01:10 INFO - files [==================> ] 16019/41661 4m15s 23:01:10 INFO - files [===================> ] 16039/41661 4m16s 23:01:10 INFO - files [===================> ] 16067/41661 4m17s 23:01:10 INFO - files [===================> ] 16334/41661 4m11s 23:01:10 INFO - files [===================> ] 16553/41661 4m08s 23:01:10 INFO - files [===================> ] 16574/41661 4m09s 23:01:10 INFO - files [===================> ] 16603/41661 4m10s 23:01:10 INFO - files [===================> ] 16631/41661 4m11s 23:01:10 INFO - files [===================> ] 16657/41661 4m12s 23:01:10 INFO - files [===================> ] 16669/41661 4m13s 23:01:10 INFO - files [===================> ] 16719/41661 4m14s 23:01:10 INFO - files [===================> ] 16745/41661 4m15s 23:01:10 INFO - files [===================> ] 16803/41661 4m15s 23:01:10 INFO - files [====================> ] 16864/41661 4m15s 23:01:10 INFO - files [====================> ] 16956/41661 4m14s 23:01:10 INFO - files [====================> ] 16969/41661 4m15s 23:01:10 INFO - files [====================> ] 16982/41661 4m17s 23:01:10 INFO - files [====================> ] 16989/41661 4m18s 23:01:10 INFO - files [====================> ] 16999/41661 4m20s 23:01:10 INFO - files [====================> ] 17013/41661 4m21s 23:01:10 INFO - files [====================> ] 17023/41661 4m23s 23:01:10 INFO - files [====================> ] 17038/41661 4m24s 23:01:10 INFO - files [====================> ] 17045/41661 4m25s 23:01:10 INFO - files [====================> ] 17067/41661 4m26s 23:01:10 INFO - files [====================> ] 17095/41661 4m27s 23:01:10 INFO - files [====================> ] 17272/41661 4m24s 23:01:10 INFO - files [====================> ] 17305/41661 4m24s 23:01:10 INFO - files [====================> ] 17333/41661 4m25s 23:01:10 INFO - files [====================> ] 17362/41661 4m26s 23:01:10 INFO - files [====================> ] 17378/41661 4m27s 23:01:10 INFO - files [====================> ] 17407/41661 4m28s 23:01:10 INFO - files [====================> ] 17445/41661 4m28s 23:01:10 INFO - files [====================> ] 17509/41661 4m28s 23:01:10 INFO - files [====================> ] 17535/41661 4m29s 23:01:10 INFO - files [====================> ] 17561/41661 4m29s 23:01:10 INFO - files [=====================> ] 17686/41661 4m28s 23:01:10 INFO - files [=====================> ] 17728/41661 4m29s 23:01:10 INFO - files [=====================> ] 17740/41661 4m31s 23:01:10 INFO - files [=====================> ] 17753/41661 4m32s 23:01:10 INFO - files [=====================> ] 17758/41661 4m33s 23:01:10 INFO - files [=====================> ] 17763/41661 4m35s 23:01:10 INFO - files [=====================> ] 17873/41661 4m34s 23:01:10 INFO - files [=====================> ] 17949/41661 4m33s 23:01:10 INFO - files [=====================> ] 17964/41661 4m34s 23:01:10 INFO - files [=====================> ] 17976/41661 4m35s 23:01:10 INFO - files [=====================> ] 17986/41661 4m36s 23:01:10 INFO - files [=====================> ] 18005/41661 4m37s 23:01:10 INFO - files [=====================> ] 18037/41661 4m38s 23:01:10 INFO - files [=====================> ] 18098/41661 4m38s 23:01:10 INFO - files [======================> ] 18463/41661 4m29s 23:01:10 INFO - files [======================> ] 18814/41661 4m21s 23:01:10 INFO - files [=======================> ] 19316/41661 4m10s 23:01:10 INFO - files [=======================> ] 19530/41661 4m06s 23:01:10 INFO - files [=======================> ] 19566/41661 4m07s 23:01:10 INFO - files [=======================> ] 19582/41661 4m07s 23:01:10 INFO - files [=======================> ] 19609/41661 4m09s 23:01:10 INFO - files [=======================> ] 19622/41661 4m09s 23:01:10 INFO - files [=======================> ] 19715/41661 4m08s 23:01:10 INFO - files [=======================> ] 19761/41661 4m08s 23:01:10 INFO - files [=======================> ] 19805/41661 4m08s 23:01:10 INFO - files [=======================> ] 19859/41661 4m08s 23:01:10 INFO - files [=======================> ] 19964/41661 4m07sensuring https://hg.mozilla.org/releases/mozilla-beta@1522cb56a651b62675f392d4064bd4365aac07f4 is available at c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src 23:01:10 INFO - (sharing from existing pooled repository 8ba995b74e18334ab3707f27e9eb8f4e37ba3d29) 23:01:10 INFO - searching for changes 23:01:10 INFO - adding changesets 23:01:10 INFO - adding manifests 23:01:10 INFO - adding file changes 23:01:10 INFO - 23:01:10 INFO - 23:01:10 INFO - transaction abort! 23:01:36 INFO - rollback completed 23:01:36 INFO - stream ended unexpectedly (got 0 bytes, expected 4) 23:01:36 INFO - (retrying after network failure on attempt 1 of 3) 23:01:36 INFO - (waiting 3.27s before retry) 23:07:22 INFO - 23:07:22 INFO - searching [ <=> ] 2 23:07:22 INFO - 23:07:22 INFO - 23:07:22 INFO - changesets [ ] 1/31412 23:07:22 INFO - changesets [====> ] 3048/31412 23:07:22 INFO - changesets [==========> ] 6838/31412 23:07:22 INFO - changesets [==============> ] 9908/31412 07s 23:07:22 INFO - changesets [==================> ] 12571/31412 06s 23:07:22 INFO - changesets [======================> ] 14960/31412 06s 23:07:22 INFO - changesets [=========================> ] 16802/31412 06s 23:07:22 INFO - changesets [===========================> ] 18037/31412 06s 23:07:22 INFO - changesets [============================> ] 19210/31412 06s 23:07:22 INFO - changesets [==============================> ] 20326/31412 05s 23:07:22 INFO - changesets [================================> ] 21408/31412 05s 23:07:22 INFO - changesets [==================================> ] 22447/31412 05s 23:07:22 INFO - changesets [===================================> ] 23447/31412 05s 23:07:22 INFO - changesets [=====================================> ] 24423/31412 04s 23:07:22 INFO - changesets [======================================> ] 25386/31412 04s 23:07:22 INFO - changesets [========================================> ] 26312/31412 03s 23:07:22 INFO - changesets [=========================================> ] 27210/31412 03s 23:07:22 INFO - changesets [==========================================> ] 28081/31412 03s 23:07:22 INFO - changesets [============================================> ] 28939/31412 02s 23:07:22 INFO - changesets [=============================================> ] 29778/31412 02s 23:07:22 INFO - changesets [==============================================> ] 30595/31412 01s 23:07:22 INFO - changesets [===============================================> ] 31394/31412 01s 23:07:22 INFO - 23:07:22 INFO - 23:07:22 INFO - manifests [ ] 1/31412 23:07:22 INFO - manifests [> ] 727/31412 23:07:22 INFO - manifests [==> ] 2176/31412 33s 23:07:22 INFO - manifests [===> ] 2887/31412 38s 23:07:22 INFO - manifests [===> ] 2893/31412 50s 23:07:22 INFO - manifests [===> ] 2900/31412 1m02s 23:07:22 INFO - manifests [===> ] 2912/31412 1m15s 23:07:22 INFO - manifests [===> ] 2916/31412 1m28s 23:07:22 INFO - manifests [===> ] 2925/31412 1m40s 23:07:22 INFO - manifests [===> ] 2929/31412 1m53s 23:07:22 INFO - manifests [===> ] 2935/31412 2m06s 23:07:22 INFO - manifests [===> ] 2941/31412 2m19s 23:07:22 INFO - manifests [===> ] 2949/31412 2m32s 23:07:22 INFO - manifests [===> ] 2964/31412 2m44s 23:07:22 INFO - manifests [===> ] 2968/31412 2m57s 23:07:22 INFO - manifests [===> ] 2976/31412 3m10s 23:07:22 INFO - manifests [===> ] 2991/31412 3m23s 23:07:22 INFO - manifests [===> ] 2996/31412 3m36s 23:07:22 INFO - manifests [===> ] 3002/31412 3m50s 23:07:22 INFO - manifests [===> ] 3010/31412 4m03s 23:07:22 INFO - manifests [===> ] 3019/31412 4m16s 23:07:22 INFO - manifests [===> ] 3022/31412 4m29s 23:07:22 INFO - manifests [===> ] 3027/31412 4m43s 23:07:22 INFO - manifests [===> ] 3030/31412 4m57s 23:07:22 INFO - manifests [=====> ] 4284/31412 3m28s 23:07:22 INFO - manifests [=========> ] 6670/31412 2m07s 23:07:22 INFO - manifests [============> ] 8736/31412 1m32s 23:07:22 INFO - manifests [=============> ] 9667/31412 1m23s 23:07:22 INFO - manifests [================> ] 11235/31412 1m08s 23:07:22 INFO - manifests [=================> ] 12034/31412 1m12s 23:07:22 INFO - manifests [===================> ] 13226/31412 1m04s 23:07:22 INFO - manifests [=====================> ] 14012/31412 59s 23:07:22 INFO - manifests [======================> ] 14972/31412 53s 23:07:22 INFO - manifests [======================> ] 14977/31412 55s 23:07:22 INFO - manifests [=======================> ] 15536/31412 53s 23:07:22 INFO - manifests [=======================> ] 15641/31412 54s 23:07:22 INFO - manifests [========================> ] 15875/31412 54s 23:07:22 INFO - manifests [========================> ] 16075/31412 54s 23:07:22 INFO - manifests [=========================> ] 16415/31412 53s 23:07:22 INFO - manifests [==========================> ] 17113/31412 51s 23:07:22 INFO - manifests [===========================> ] 17689/31412 50s 23:07:22 INFO - manifests [===========================> ] 18034/31412 51s 23:07:22 INFO - manifests [============================> ] 18701/31412 50s 23:07:22 INFO - manifests [=============================> ] 19422/31412 46s 23:07:22 INFO - manifests [===============================> ] 20526/31412 41s 23:07:22 INFO - manifests [================================> ] 21040/31412 38s 23:07:22 INFO - manifests [================================> ] 21056/31412 39s 23:07:22 INFO - manifests [================================> ] 21081/31412 39s 23:07:22 INFO - manifests [================================> ] 21152/31412 40s 23:07:22 INFO - manifests [=================================> ] 21792/31412 38s 23:07:22 INFO - manifests [==================================> ] 22240/31412 36s 23:07:22 INFO - manifests [===================================> ] 22618/31412 34s 23:07:22 INFO - manifests [===================================> ] 23223/31412 32s 23:07:22 INFO - manifests [=====================================> ] 24239/31412 27s 23:07:22 INFO - manifests [======================================> ] 24512/31412 27s 23:07:22 INFO - manifests [======================================> ] 24575/31412 27s 23:07:22 INFO - manifests [======================================> ] 25122/31412 26s 23:07:22 INFO - manifests [=======================================> ] 25666/31412 23s 23:07:22 INFO - manifests [=========================================> ] 26680/31412 19s 23:07:22 INFO - manifests [==========================================> ] 27306/31412 17s 23:07:22 INFO - manifests [===========================================> ] 27911/31412 14s 23:07:22 INFO - manifests [============================================> ] 28517/31412 12s 23:07:22 INFO - manifests [=============================================> ] 29122/31412 10s 23:07:22 INFO - manifests [=============================================> ] 29440/31412 08s 23:07:22 INFO - 23:07:22 INFO - 23:07:22 INFO - files [ ] 1/32862 23:07:22 INFO - files [ ] 401/32862 9h44m 23:07:22 INFO - files [ ] 467/32862 8h22m 23:07:22 INFO - files [ ] 529/32862 7h23m 23:07:22 INFO - files [ ] 576/32862 6h47m 23:07:22 INFO - files [> ] 1065/32862 3h38m 23:07:22 INFO - files [=> ] 1360/32862 2h49m 23:07:22 INFO - files [=> ] 1625/32862 2h21m 23:07:22 INFO - files [==> ] 2136/32862 1h46m 23:07:22 INFO - files [===> ] 2992/32862 1h14m 23:07:22 INFO - files [====> ] 3370/32862 1h05m 23:07:22 INFO - files [====> ] 3412/32862 1h04m 23:07:22 INFO - files [====> ] 3829/32862 55m59s 23:07:22 INFO - files [=====> ] 4136/32862 51m24s 23:07:22 INFO - files [=====> ] 4472/32862 47m06s 23:07:22 INFO - files [======> ] 4539/32862 46m25s 23:07:22 INFO - files [======> ] 4790/32862 43m41s 23:07:22 INFO - files [=======> ] 5336/32862 38m32s 23:07:22 INFO - files [========> ] 6164/32862 32m29s 23:07:22 INFO - files [=========> ] 6463/32862 30m43s 23:07:22 INFO - files [=========> ] 6502/32862 30m36s 23:07:22 INFO - files [=========> ] 6702/32862 29m31s 23:07:22 INFO - files [=========> ] 6983/32862 28m05s 23:07:22 INFO - files [==========> ] 7261/32862 26m47s 23:07:22 INFO - files [==========> ] 7557/32862 25m30s 23:07:22 INFO - files [===========> ] 8064/32862 23m28s 23:07:22 INFO - files [===========> ] 8139/32862 23m14s 23:07:22 INFO - files [===========> ] 8234/32862 22m55s 23:07:22 INFO - files [============> ] 8589/32862 21m42s 23:07:22 INFO - files [=============> ] 9132/32862 20m00s 23:07:22 INFO - files [=============> ] 9398/32862 19m16s 23:07:22 INFO - files [==============> ] 9921/32862 17m53s 23:07:22 INFO - files [===============> ] 10415/32862 16m42s 23:07:22 INFO - files [===============> ] 10750/32862 15m59s 23:07:22 INFO - files [================> ] 11046/32862 15m22s 23:07:22 INFO - files [=================> ] 12030/32862 13m31s 23:07:22 INFO - files [=================> ] 12197/32862 13m15s 23:07:22 INFO - files [==================> ] 12321/32862 13m04s 23:07:22 INFO - files [==================> ] 12528/32862 12m45s 23:07:22 INFO - files [==================> ] 12709/32862 12m29s 23:07:22 INFO - files [===================> ] 13280/32862 11m38s 23:07:22 INFO - files [===================> ] 13404/32862 11m29s 23:07:22 INFO - files [====================> ] 13816/32862 10m55s 23:07:22 INFO - files [====================> ] 13849/32862 10m55s 23:07:22 INFO - files [====================> ] 13880/32862 10m54s 23:07:22 INFO - files [====================> ] 13933/32862 10m51s 23:07:22 INFO - files [====================> ] 14012/32862 10m46s 23:07:22 INFO - files [=====================> ] 14225/32862 10m31s 23:07:22 INFO - files [=====================> ] 14256/32862 10m30s 23:07:22 INFO - files [=====================> ] 14291/32862 10m29s 23:07:22 INFO - files [=====================> ] 14494/32862 10m15s 23:07:22 INFO - files [=====================> ] 14563/32862 10m11s 23:07:22 INFO - files [=====================> ] 14662/32862 10m05s 23:07:22 INFO - files [======================> ] 14773/32862 9m58s 23:07:22 INFO - files [======================> ] 14806/32862 9m57s 23:07:22 INFO - files [======================> ] 14819/32862 9m58s 23:07:22 INFO - files [======================> ] 14825/32862 9m59s 23:07:22 INFO - files [======================> ] 14983/32862 9m49s 23:07:22 INFO - files [======================> ] 15034/32862 9m46s 23:07:22 INFO - files [=======================> ] 15483/32862 9m16s 23:07:22 INFO - files [========================> ] 16084/32862 8m38s 23:07:22 INFO - files [========================> ] 16130/32862 8m36s 23:07:22 INFO - files [========================> ] 16384/32862 8m21s 23:07:22 INFO - files [=========================> ] 16670/32862 8m05s 23:07:22 INFO - files [=========================> ] 16879/32862 7m54s 23:07:22 INFO - files [==========================> ] 17084/32862 7m43s 23:07:22 INFO - files [==========================> ] 17158/32862 7m40s 23:07:22 INFO - files [==========================> ] 17206/32862 7m39s 23:07:22 INFO - files [==========================> ] 17326/32862 7m33s 23:07:22 INFO - files [==========================> ] 17430/32862 7m28s 23:07:22 INFO - files [==========================> ] 17458/32862 7m28s 23:07:22 INFO - files [==========================> ] 17505/32862 7m26s 23:07:22 INFO - files [==========================> ] 17672/32862 7m18s 23:07:22 INFO - files [===========================> ] 17785/32862 7m13s 23:07:22 INFO - files [===========================> ] 17950/32862 7m05s 23:07:22 INFO - files [===========================> ] 18185/32862 6m54s 23:07:22 INFO - files [============================> ] 18339/32862 6m47s 23:07:22 INFO - files [============================> ] 18534/32862 6m38s 23:07:22 INFO - files [============================> ] 18726/32862 6m29s 23:07:22 INFO - files [============================> ] 18757/32862 6m29s 23:07:22 INFO - files [============================> ] 18787/32862 6m28s 23:07:22 INFO - files [============================> ] 18840/32862 6m26s 23:07:22 INFO - files [============================> ] 18914/32862 6m23s 23:07:22 INFO - files [=============================> ] 19166/32862 6m12s 23:07:22 INFO - files [=============================> ] 19567/32862 5m55s 23:07:22 INFO - files [==============================> ] 19776/32862 5m46s 23:07:22 INFO - files [==============================> ] 20025/32862 5m36s 23:07:22 INFO - files [===============================> ] 20307/32862 5m25s 23:07:22 INFO - files [===============================> ] 20483/32862 5m18s 23:07:22 INFO - files [===============================> ] 20528/32862 5m17s 23:07:22 INFO - files [===============================> ] 20665/32862 5m12s 23:07:22 INFO - files [===============================> ] 20704/32862 5m11s 23:07:22 INFO - files [===============================> ] 20794/32862 5m08s 23:07:22 INFO - files [===============================> ] 20825/32862 5m07s 23:07:22 INFO - files [================================> ] 20862/32862 5m06s 23:07:22 INFO - files [================================> ] 20928/32862 5m04s 23:07:22 INFO - files [================================> ] 21060/32862 5m00s 23:07:22 INFO - files [================================> ] 21118/32862 4m58s 23:07:22 INFO - files [================================> ] 21208/32862 4m55s 23:07:22 INFO - files [================================> ] 21303/32862 4m52s 23:07:22 INFO - files [================================> ] 21382/32862 4m50s 23:07:22 INFO - files [================================> ] 21432/32862 4m49s 23:07:22 INFO - files [=================================> ] 22041/32862 4m26s 23:07:22 INFO - files [==================================> ] 22194/32862 4m21s 23:07:22 INFO - files [==================================> ] 22508/32862 4m10s 23:07:22 INFO - files [==================================> ] 22637/32862 4m06s 23:07:22 INFO - files [===================================> ] 22785/32862 4m02s 23:07:22 INFO - files [===================================> ] 23109/32862 3m51s 23:07:22 INFO - files [===================================> ] 23379/32862 3m43s 23:07:22 INFO - files [====================================> ] 23501/32862 3m39s 23:07:22 INFO - files [====================================> ] 23614/32862 3m36s 23:07:22 INFO - files [====================================> ] 23694/32862 3m33s 23:07:22 INFO - files [====================================> ] 23763/32862 3m32s 23:07:22 INFO - files [====================================> ] 23829/32862 3m30s 23:07:22 INFO - files [=====================================> ] 24022/32862 3m24s 23:07:22 INFO - files [=====================================> ] 24104/32862 3m22s 23:07:22 INFO - files [=====================================> ] 24226/32862 3m19s 23:07:22 INFO - files [=====================================> ] 24484/32862 3m11s 23:07:22 INFO - files [=====================================> ] 24606/32862 3m08s 23:07:22 INFO - files [======================================> ] 25038/32862 2m55s 23:07:22 INFO - files [======================================> ] 25122/32862 2m53s 23:07:22 INFO - files [=======================================> ] 25579/32862 2m40s 23:07:22 INFO - files [=======================================> ] 25734/32862 2m36s 23:07:22 INFO - files [=======================================> ] 25848/32862 2m33s 23:07:22 INFO - files [========================================> ] 26440/32862 2m17s 23:07:22 INFO - files [========================================> ] 26538/32862 2m15s 23:07:22 INFO - files [=========================================> ] 26634/32862 2m13s 23:07:22 INFO - files [=========================================> ] 26766/32862 2m10s 23:07:22 INFO - files [=========================================> ] 26808/32862 2m09s 23:07:22 INFO - files [=========================================> ] 26914/32862 2m06s 23:07:22 INFO - files [=========================================> ] 27041/32862 2m03s 23:07:22 INFO - files [=========================================> ] 27108/32862 2m02s 23:07:22 INFO - files [==========================================> ] 27187/32862 2m00s 23:07:22 INFO - files [==========================================> ] 27273/32862 1m58s 23:07:22 INFO - files [==========================================> ] 27329/32862 1m57s 23:07:22 INFO - files [==========================================> ] 27444/32862 1m54s 23:07:22 INFO - files [==========================================> ] 27539/32862 1m52s 23:07:22 INFO - files [==========================================> ] 27621/32862 1m50s 23:07:22 INFO - files [==========================================> ] 27739/32862 1m47s 23:07:22 INFO - files [===========================================> ] 27946/32862 1m42s 23:07:22 INFO - files [===========================================> ] 28129/32862 1m38s 23:07:22 INFO - files [===========================================> ] 28270/32862 1m35s 23:07:22 INFO - files [===========================================> ] 28434/32862 1m31s 23:07:22 INFO - files [============================================> ] 28494/32862 1m30s 23:07:22 INFO - files [============================================> ] 28552/32862 1m29s 23:07:22 INFO - files [============================================> ] 28579/32862 1m28s 23:07:22 INFO - files [============================================> ] 28691/32862 1m26s 23:07:22 INFO - files [============================================> ] 28747/32862 1m25s 23:07:22 INFO - files [============================================> ] 28799/32862 1m24s 23:07:22 INFO - files [============================================> ] 28861/32862 1m22s 23:07:22 INFO - files [============================================> ] 28932/32862 1m21s 23:07:22 INFO - files [============================================> ] 28999/32862 1m19s 23:07:22 INFO - files [=============================================> ] 29096/32862 1m17s 23:07:22 INFO - 23:07:22 INFO - ensuring https://hg.mozilla.org/releases/mozilla-beta@1522cb56a651b62675f392d4064bd4365aac07f4 is available at c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src 23:07:22 INFO - (existing repository shared store: C:\builds\hg-shared\8ba995b74e18334ab3707f27e9eb8f4e37ba3d29\.hg) 23:07:22 INFO - (pulling to obtain 1522cb56a651b62675f392d4064bd4365aac07f4) 23:07:22 INFO - searching for changes 23:07:22 INFO - adding changesets 23:07:22 INFO - adding manifests 23:07:22 INFO - adding file changes 23:07:22 INFO - added 31412 changesets with 54977 changes to 29139 files (+1 heads) 23:12:11 INFO - 23:12:11 INFO - updating [ ] 100/149890 23:12:11 INFO - updating [ ] 1000/149890 23:12:11 INFO - updating [ ] 1700/149890 3m20s 23:12:11 INFO - updating [ ] 2000/149890 4m21s 23:12:11 INFO - updating [ ] 2400/149890 4m57s 23:12:11 INFO - updating [> ] 3200/149890 5m22s 23:12:11 INFO - updating [> ] 3300/149890 6m13s 23:12:11 INFO - updating [> ] 3900/149890 6m33s 23:12:11 INFO - updating [> ] 4600/149890 6m05s 23:12:11 INFO - updating [> ] 5000/149890 6m15s 23:12:11 INFO - updating [> ] 5600/149890 6m06s 23:12:11 INFO - updating [> ] 6200/149890 5m53s 23:12:11 INFO - updating [=> ] 6700/149890 5m50s 23:12:11 INFO - updating [=> ] 7400/149890 5m35s 23:12:11 INFO - updating [=> ] 7700/149890 5m41s 23:12:11 INFO - updating [=> ] 8400/149890 5m34s 23:12:11 INFO - updating [=> ] 9100/149890 5m23s 23:12:11 INFO - updating [==> ] 10000/149890 5m11s 23:12:11 INFO - updating [==> ] 10500/149890 5m10s 23:12:11 INFO - updating [==> ] 11200/149890 5m03s 23:12:11 INFO - updating [==> ] 11700/149890 5m02s 23:12:11 INFO - updating [==> ] 12300/149890 4m58s 23:12:11 INFO - updating [===> ] 13100/149890 4m50s 23:12:11 INFO - updating [===> ] 13800/149890 4m44s 23:12:11 INFO - updating [===> ] 14400/149890 4m45s 23:12:11 INFO - updating [===> ] 15200/149890 4m37s 23:12:11 INFO - updating [===> ] 15800/149890 4m36s 23:12:11 INFO - updating [====> ] 16500/149890 4m31s 23:12:11 INFO - updating [====> ] 17000/149890 4m31s 23:12:11 INFO - updating [====> ] 17700/149890 4m27s 23:12:11 INFO - updating [====> ] 18400/149890 4m24s 23:12:11 INFO - updating [=====> ] 19200/149890 4m20s 23:12:11 INFO - updating [=====> ] 19700/149890 4m22s 23:12:11 INFO - updating [=====> ] 20300/149890 4m20s 23:12:11 INFO - updating [=====> ] 20800/149890 4m20s 23:12:11 INFO - updating [=====> ] 21500/149890 4m16s 23:12:11 INFO - updating [=====> ] 22300/149890 4m13s 23:12:11 INFO - updating [======> ] 23200/149890 4m09s 23:12:11 INFO - updating [======> ] 23900/149890 4m06s 23:12:11 INFO - updating [======> ] 24400/149890 4m05s 23:12:11 INFO - updating [======> ] 25000/149890 4m03s 23:12:12 INFO - updating [=======> ] 25600/149890 4m02s 23:12:12 INFO - updating [=======> ] 25900/149890 4m04s 23:12:12 INFO - updating [=======> ] 26300/149890 4m08s 23:12:12 INFO - updating [=======> ] 26500/149890 4m14s 23:12:12 INFO - updating [=======> ] 26800/149890 4m20s 23:12:12 INFO - updating [=======> ] 27400/149890 4m20s 23:12:12 INFO - updating [=======> ] 27700/149890 4m23s 23:12:12 INFO - updating [=======> ] 28300/149890 4m21s 23:12:12 INFO - updating [========> ] 29000/149890 4m17s 23:12:12 INFO - updating [========> ] 29800/149890 4m13s 23:12:12 INFO - updating [========> ] 30400/149890 4m11s 23:12:12 INFO - updating [========> ] 31100/149890 4m08s 23:12:12 INFO - updating [========> ] 31700/149890 4m08s 23:12:12 INFO - updating [=========> ] 32400/149890 4m05s 23:12:12 INFO - updating [=========> ] 33100/149890 4m02s 23:12:12 INFO - updating [=========> ] 33900/149890 3m59s 23:12:12 INFO - updating [=========> ] 34600/149890 3m56s 23:12:12 INFO - updating [==========> ] 35300/149890 3m53s 23:12:12 INFO - updating [==========> ] 36200/149890 3m49s 23:12:12 INFO - updating [==========> ] 37100/149890 3m45s 23:12:12 INFO - updating [==========> ] 37500/149890 3m45s 23:12:12 INFO - updating [===========> ] 38400/149890 3m41s 23:12:12 INFO - updating [===========> ] 38700/149890 3m43s 23:12:12 INFO - updating [===========> ] 38800/149890 3m45s 23:12:12 INFO - updating [===========> ] 39100/149890 3m46s 23:12:12 INFO - updating [===========> ] 39800/149890 3m44s 23:12:12 INFO - updating [===========> ] 40200/149890 3m44s 23:12:12 INFO - updating [===========> ] 40600/149890 3m44s 23:12:12 INFO - updating [===========> ] 41000/149890 3m44s 23:12:12 INFO - updating [===========> ] 41300/149890 3m45s 23:12:12 INFO - updating [============> ] 41600/149890 3m47s 23:12:12 INFO - updating [============> ] 42100/149890 3m46s 23:12:12 INFO - updating [============> ] 42600/149890 3m45s 23:12:12 INFO - updating [============> ] 43200/149890 3m43s 23:12:12 INFO - updating [============> ] 43900/149890 3m41s 23:12:12 INFO - updating [============> ] 44200/149890 3m42s 23:12:12 INFO - updating [=============> ] 44700/149890 3m41s 23:12:12 INFO - updating [=============> ] 45000/149890 3m42s 23:12:12 INFO - updating [=============> ] 45200/149890 3m43s 23:12:12 INFO - updating [=============> ] 45600/149890 3m43s 23:12:12 INFO - updating [=============> ] 45900/149890 3m45s 23:12:12 INFO - updating [=============> ] 46300/149890 3m45s 23:12:12 INFO - updating [=============> ] 46700/149890 3m45s 23:12:12 INFO - updating [=============> ] 47000/149890 3m46s 23:12:12 INFO - updating [=============> ] 47300/149890 3m46s 23:12:12 INFO - updating [=============> ] 47600/149890 3m46s 23:12:12 INFO - updating [==============> ] 48100/149890 3m46s 23:12:12 INFO - updating [==============> ] 48700/149890 3m44s 23:12:12 INFO - updating [==============> ] 49000/149890 3m45s 23:12:12 INFO - updating [==============> ] 49500/149890 3m43s 23:12:12 INFO - updating [==============> ] 50300/149890 3m40s 23:12:12 INFO - updating [==============> ] 51000/149890 3m38s 23:12:12 INFO - updating [===============> ] 51700/149890 3m35s 23:12:12 INFO - updating [===============> ] 52500/149890 3m32s 23:12:12 INFO - updating [===============> ] 53700/149890 3m27s 23:12:12 INFO - updating [================> ] 54700/149890 3m23s 23:12:12 INFO - updating [================> ] 55300/149890 3m23s 23:12:12 INFO - updating [================> ] 55700/149890 3m23s 23:12:12 INFO - updating [================> ] 56500/149890 3m20s 23:12:12 INFO - updating [================> ] 57400/149890 3m16s 23:12:12 INFO - updating [=================> ] 58100/149890 3m14s 23:12:12 INFO - updating [=================> ] 58600/149890 3m13s 23:12:12 INFO - updating [=================> ] 59300/149890 3m11s 23:12:12 INFO - updating [=================> ] 60400/149890 3m07s 23:12:12 INFO - updating [==================> ] 61400/149890 3m03s 23:12:12 INFO - updating [==================> ] 62500/149890 3m00s 23:12:12 INFO - updating [==================> ] 63300/149890 2m57s 23:12:12 INFO - updating [===================> ] 64000/149890 2m55s 23:12:12 INFO - updating [===================> ] 64800/149890 2m53s 23:12:12 INFO - updating [===================> ] 65400/149890 2m52s 23:12:12 INFO - updating [===================> ] 66000/149890 2m50s 23:12:12 INFO - updating [===================> ] 66600/149890 2m49s 23:12:12 INFO - updating [====================> ] 67300/149890 2m47s 23:12:12 INFO - updating [====================> ] 68000/149890 2m45s 23:12:12 INFO - updating [====================> ] 69100/149890 2m42s 23:12:12 INFO - updating [====================> ] 69500/149890 2m41s 23:12:12 INFO - updating [=====================> ] 70400/149890 2m39s 23:12:12 INFO - updating [=====================> ] 71600/149890 2m35s 23:12:12 INFO - updating [=====================> ] 72400/149890 2m33s 23:12:12 INFO - updating [======================> ] 73500/149890 2m29s 23:12:12 INFO - updating [======================> ] 74000/149890 2m28s 23:12:12 INFO - updating [======================> ] 75200/149890 2m25s 23:12:12 INFO - updating [======================> ] 76000/149890 2m23s 23:12:12 INFO - updating [======================> ] 76200/149890 2m23s 23:12:12 INFO - updating [======================> ] 76400/149890 2m24s 23:12:12 INFO - updating [=======================> ] 77500/149890 2m21s 23:12:12 INFO - updating [=======================> ] 78500/149890 2m18s 23:12:12 INFO - updating [=======================> ] 79400/149890 2m16s 23:12:12 INFO - updating [========================> ] 80600/149890 2m12s 23:12:12 INFO - updating [========================> ] 81400/149890 2m10s 23:12:12 INFO - updating [========================> ] 82500/149890 2m08s 23:12:12 INFO - updating [=========================> ] 83300/149890 2m06s 23:12:12 INFO - updating [=========================> ] 84200/149890 2m03s 23:12:12 INFO - updating [=========================> ] 85200/149890 2m01s 23:12:12 INFO - updating [=========================> ] 85900/149890 2m00s 23:12:12 INFO - updating [==========================> ] 86900/149890 1m57s 23:12:12 INFO - updating [==========================> ] 87500/149890 1m56s 23:12:12 INFO - updating [==========================> ] 88100/149890 1m55s 23:12:12 INFO - updating [==========================> ] 88800/149890 1m54s 23:12:12 INFO - updating [===========================> ] 89600/149890 1m52s 23:12:12 INFO - updating [===========================> ] 90200/149890 1m51s 23:12:12 INFO - updating [===========================> ] 90500/149890 1m51s 23:12:12 INFO - updating [===========================> ] 91300/149890 1m49s 23:12:12 INFO - updating [===========================> ] 91700/149890 1m49s 23:12:12 INFO - updating [===========================> ] 92400/149890 1m47s 23:12:12 INFO - updating [============================> ] 92800/149890 1m47s 23:12:12 INFO - updating [============================> ] 93900/149890 1m44s 23:12:12 INFO - updating [============================> ] 94600/149890 1m43s 23:12:12 INFO - updating [============================> ] 95300/149890 1m41s 23:12:12 INFO - updating [=============================> ] 95800/149890 1m41s 23:12:12 INFO - updating [=============================> ] 96300/149890 1m40s 23:12:12 INFO - updating [=============================> ] 97000/149890 1m39s 23:12:12 INFO - updating [=============================> ] 97600/149890 1m38s 23:12:12 INFO - updating [=============================> ] 98200/149890 1m37s 23:12:12 INFO - updating [==============================> ] 98900/149890 1m35s 23:12:12 INFO - updating [==============================> ] 99300/149890 1m35s 23:12:12 INFO - updating [==============================> ] 99400/149890 1m35s 23:12:12 INFO - updating [==============================> ] 99600/149890 1m35s 23:12:12 INFO - updating [==============================> ] 100100/149890 1m34s 23:12:12 INFO - updating [==============================> ] 100800/149890 1m33s 23:12:12 INFO - updating [==============================> ] 101100/149890 1m33s 23:12:12 INFO - updating [==============================> ] 101800/149890 1m31s 23:12:12 INFO - updating [===============================> ] 102400/149890 1m30s 23:12:12 INFO - updating [===============================> ] 103400/149890 1m28s 23:12:12 INFO - updating [===============================> ] 104000/149890 1m27s 23:12:12 INFO - updating [===============================> ] 104400/149890 1m26s 23:12:12 INFO - updating [===============================> ] 105100/149890 1m25s 23:12:12 INFO - updating [================================> ] 105800/149890 1m23s 23:12:12 INFO - updating [================================> ] 106400/149890 1m22s 23:12:12 INFO - updating [================================> ] 106800/149890 1m22s 23:12:12 INFO - updating [================================> ] 107100/149890 1m21s 23:12:12 INFO - updating [================================> ] 107900/149890 1m20s 23:12:12 INFO - updating [================================> ] 108400/149890 1m19s 23:12:12 INFO - updating [=================================> ] 108800/149890 1m18s 23:12:12 INFO - updating [=================================> ] 109500/149890 1m17s 23:12:12 INFO - updating [=================================> ] 110200/149890 1m16s 23:12:12 INFO - updating [=================================> ] 111200/149890 1m13s 23:12:12 INFO - updating [==================================> ] 111900/149890 1m12s 23:12:12 INFO - updating [==================================> ] 112500/149890 1m11s 23:12:12 INFO - updating [==================================> ] 113200/149890 1m10s 23:12:12 INFO - updating [==================================> ] 113700/149890 1m09s 23:12:12 INFO - updating [==================================> ] 114200/149890 1m08s 23:12:12 INFO - updating [===================================> ] 114900/149890 1m07s 23:12:12 INFO - updating [===================================> ] 115500/149890 1m05s 23:12:12 INFO - updating [===================================> ] 116200/149890 1m04s 23:12:12 INFO - updating [===================================> ] 116300/149890 1m04s 23:12:12 INFO - updating [===================================> ] 116600/149890 1m04s 23:12:12 INFO - updating [===================================> ] 117200/149890 1m03s 23:12:12 INFO - updating [====================================> ] 118100/149890 1m01s 23:12:12 INFO - updating [=====================================> ] 119200/149890 58s 23:12:12 INFO - updating [======================================> ] 119800/149890 57s 23:12:12 INFO - updating [======================================> ] 120600/149890 56s 23:12:12 INFO - updating [======================================> ] 121300/149890 54s 23:12:12 INFO - updating [=======================================> ] 122400/149890 52s 23:12:12 INFO - updating [=======================================> ] 122900/149890 51s 23:12:12 INFO - updating [=======================================> ] 123600/149890 50s 23:12:12 INFO - updating [=======================================> ] 124400/149890 48s 23:12:12 INFO - updating [========================================> ] 125500/149890 46s 23:12:12 INFO - updating [========================================> ] 126400/149890 44s 23:12:12 INFO - updating [========================================> ] 127000/149890 43s 23:12:12 INFO - updating [========================================> ] 127100/149890 43s 23:12:12 INFO - updating [========================================> ] 128100/149890 41s 23:12:12 INFO - updating [=========================================> ] 129100/149890 39s 23:12:12 INFO - updating [=========================================> ] 130000/149890 37s 23:12:12 INFO - updating [=========================================> ] 130900/149890 35s 23:12:12 INFO - updating [=========================================> ] 131200/149890 35s 23:12:12 INFO - updating [=========================================> ] 131300/149890 35s 23:12:12 INFO - updating [==========================================> ] 132000/149890 34s 23:12:12 INFO - updating [==========================================> ] 132900/149890 32s 23:12:12 INFO - updating [==========================================> ] 133500/149890 31s 23:12:12 INFO - updating [==========================================> ] 134400/149890 29s 23:12:12 INFO - updating [===========================================> ] 135300/149890 27s 23:12:12 INFO - updating [===========================================> ] 135700/149890 27s 23:12:12 INFO - updating [===========================================> ] 136100/149890 26s 23:12:12 INFO - updating [===========================================> ] 136500/149890 25s 23:12:12 INFO - updating [===========================================> ] 137300/149890 24s 23:12:12 INFO - updating [============================================> ] 138000/149890 22s 23:12:12 INFO - updating [============================================> ] 138900/149890 21s 23:12:12 INFO - updating [============================================> ] 139600/149890 19s 23:12:12 INFO - updating [============================================> ] 140200/149890 18s 23:12:12 INFO - updating [=============================================> ] 140800/149890 17s 23:12:12 INFO - updating [=============================================> ] 141300/149890 16s 23:12:12 INFO - updating [=============================================> ] 142100/149890 15s 23:12:12 INFO - updating [=============================================> ] 142500/149890 14s 23:12:12 INFO - updating [=============================================> ] 143000/149890 13s 23:12:12 INFO - updating [=============================================> ] 143500/149890 12s 23:12:12 INFO - updating [==============================================> ] 144100/149890 11s 23:12:12 INFO - updating [==============================================> ] 144300/149890 11s 23:12:12 INFO - updating [==============================================> ] 144600/149890 10s 23:12:12 INFO - updating [==============================================> ] 144900/149890 10s 23:12:12 INFO - updating [==============================================> ] 145500/149890 09s 23:12:12 INFO - updating [==============================================> ] 146200/149890 07s 23:12:12 INFO - updating [===============================================> ] 146900/149890 06s 23:12:12 INFO - updating [===============================================> ] 147500/149890 05s 23:12:12 INFO - updating [===============================================> ] 148000/149890 04s 23:12:12 INFO - updating [===============================================> ] 148400/149890 03s 23:12:12 INFO - updating [===============================================> ] 148900/149890 02s 23:12:12 INFO - updating [===============================================> ] 149400/149890 01s 23:12:12 INFO - updating [================================================>] 149890/149890 01s 23:12:12 INFO - 23:12:12 INFO - 149890 files updated, 0 files merged, 0 files removed, 0 files unresolved 23:12:12 INFO - updated to 1522cb56a651b62675f392d4064bd4365aac07f4 23:12:12 INFO - Return code: 0 23:12:12 INFO - Setting buildbot property comments to Bug 1330759 - Part 6: Make the null-termination asserts in nsStringBuffer::ToString into diagnostic asserts. r=froydnj, a=jcristau 23:12:12 INFO - Writing buildbot properties ['comments'] to c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\properties\comments 23:12:12 INFO - Writing to file c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\properties\comments 23:12:12 INFO - Contents: 23:12:12 INFO - comments:Bug 1330759 - Part 6: Make the null-termination asserts in nsStringBuffer::ToString into diagnostic asserts. r=froydnj, a=jcristau 23:12:12 INFO - Setting buildbot property got_revision to 1522cb56a651b62675f392d4064bd4365aac07f4 23:12:12 INFO - Writing buildbot properties ['got_revision'] to c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\properties\got_revision 23:12:12 INFO - Writing to file c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\properties\got_revision 23:12:12 INFO - Contents: 23:12:12 INFO - got_revision:1522cb56a651b62675f392d4064bd4365aac07f4 23:12:12 INFO - [mozharness: 2017-01-24 07:12:12.313000Z] Finished checkout-sources step (success) 23:12:12 INFO - [mozharness: 2017-01-24 07:12:12.313000Z] Skipping setup-mock step. 23:12:12 INFO - [mozharness: 2017-01-24 07:12:12.313000Z] Running build step. 23:12:12 INFO - Running main action method: build 23:12:12 INFO - removing old packages... 23:12:12 INFO - There wasn't any old packages to remove. 23:12:12 INFO - Using in-tree mozconfig 23:12:12 INFO - Reading from file c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src\browser/config/mozconfigs/win64/add-on-devel 23:12:12 INFO - Contents: 23:12:12 INFO - . $topsrcdir/browser/config/mozconfigs/win64/nightly 23:12:12 INFO - 23:12:12 INFO - #add-on signing is checked but not enforced 23:12:12 INFO - MOZ_REQUIRE_SIGNING=0 23:12:12 INFO - ac_add_options --with-branding=browser/branding/unofficial 23:12:12 INFO - ac_add_options --enable-update-channel=default 23:12:12 INFO - 23:12:12 INFO - #Need this to prevent name conflicts with the normal nightly build packages 23:12:12 INFO - export MOZ_PKG_SPECIAL=add-on-devel 23:12:12 INFO - mozconfig content: 23:12:12 INFO - . $topsrcdir/browser/config/mozconfigs/win64/nightly 23:12:12 INFO - 23:12:12 INFO - #add-on signing is checked but not enforced 23:12:12 INFO - MOZ_REQUIRE_SIGNING=0 23:12:12 INFO - ac_add_options --with-branding=browser/branding/unofficial 23:12:12 INFO - ac_add_options --enable-update-channel=default 23:12:12 INFO - 23:12:12 INFO - #Need this to prevent name conflicts with the normal nightly build packages 23:12:12 INFO - export MOZ_PKG_SPECIAL=add-on-devel 23:12:12 INFO - Copying c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src\browser/config/mozconfigs/win64/add-on-devel to c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src\.mozconfig 23:12:12 INFO - ['sh', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\tools\\scripts\\tooltool\\tooltool_wrapper.sh', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'https://api.pub.build.mozilla.org/tooltool/', 'setup.sh', 'c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', '/c/builds/tooltool_cache'] 23:12:12 INFO - Running command: ['sh', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\tools\\scripts\\tooltool\\tooltool_wrapper.sh', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'https://api.pub.build.mozilla.org/tooltool/', 'setup.sh', 'c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', '/c/builds/tooltool_cache'] in c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src 23:12:12 INFO - Copy/paste: sh c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\tools\scripts\tooltool\tooltool_wrapper.sh c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src\browser/config/tooltool-manifests/win64/releng.manifest https://api.pub.build.mozilla.org/tooltool/ setup.sh c:\mozilla-build\python27\python.exe C:/mozilla-build/tooltool.py -c /c/builds/tooltool_cache 23:12:12 INFO - c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src\browser/config/tooltool-manifests/win64/releng.manifest content 23:12:12 INFO - ======================================================= 23:12:12 INFO - [ 23:12:12 INFO - { 23:12:12 INFO - "size": 266240, 23:12:12 INFO - "digest": "bb345b0e700ffab4d09436981f14b5de84da55a3f18a7f09ebc4364a4488acdeab8d46f447b12ac70f2da1444a68b8ce8b8675f0dae2ccf845e966d1df0f0869", 23:12:12 INFO - "algorithm": "sha512", 23:12:12 INFO - "filename": "mozmake.exe" 23:12:12 INFO - }, 23:12:12 INFO - { 23:12:12 INFO - "version": "rustc 1.13.0 (2c6933acc 2016-11-07) repack", 23:12:12 INFO - "size": 63966131, 23:12:12 INFO - "digest": "a431492ca5ae3454e7d5de3962ff0b40d96f69a9046428a1fe310397a5dda9ba2f6b697958e8386b119d56b700563ffe1b58c63f84b527b2df320893306854cf", 23:12:12 INFO - "algorithm": "sha512", 23:12:12 INFO - "visibility": "public", 23:12:12 INFO - "filename": "rustc.tar.bz2", 23:12:12 INFO - "unpack": true 23:12:12 INFO - }, 23:12:12 INFO - { 23:12:12 INFO - "version": "cargo 0.13.0-nightly (eca9e15 2016-11-01) repack", 23:12:12 INFO - "size": 2466539, 23:12:12 INFO - "digest": "78b129bd5c933d77c1f09a24c57a652c7cf228fc986000c162f892a46a53fc0f56b8fe1ac924c7e5aaefc4728fd07b679fbf149feb4ed5f2f30c4fd2f776ab7e", 23:12:12 INFO - "algorithm": "sha512", 23:12:12 INFO - "filename": "cargo.tar.bz2", 23:12:12 INFO - "unpack": true 23:12:12 INFO - }, 23:12:12 INFO - { 23:12:12 INFO - "size": 167175, 23:12:12 INFO - "digest": "0b71a936edf5bd70cf274aaa5d7abc8f77fe8e7b5593a208f805cc9436fac646b9c4f0b43c2b10de63ff3da671497d35536077ecbc72dba7f8159a38b580f831", 23:12:12 INFO - "algorithm": "sha512", 23:12:12 INFO - "filename": "sccache.tar.bz2", 23:12:12 INFO - "unpack": true 23:12:12 INFO - }, 23:12:12 INFO - { 23:12:12 INFO - "version": "Visual Studio 2015 Update 3 14.0.25425.01 / SDK 10.0.14393.0", 23:12:12 INFO - "size": 326656969, 23:12:12 INFO - "digest": "babc414ffc0457d27f5a1ed24a8e4873afbe2f1c1a4075469a27c005e1babc3b2a788f643f825efedff95b79686664c67ec4340ed535487168a3482e68559bc7", 23:12:12 INFO - "algorithm": "sha512", 23:12:12 INFO - "filename": "vs2015u3.zip", 23:12:12 INFO - "unpack": true 23:12:12 INFO - } 23:12:12 INFO - ] 23:12:12 INFO - ======================================================= 23:12:12 INFO - Fetching... 23:12:13 INFO - Executing: ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'] 23:12:13 INFO - INFO - File mozmake.exe retrieved from local cache c:/builds/tooltool_cache 23:12:13 INFO - INFO - File rustc.tar.bz2 not present in local cache folder c:/builds/tooltool_cache 23:12:13 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:12:35 INFO - INFO - File rustc.tar.bz2 fetched from https://api.pub.build.mozilla.org/tooltool/ as c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src\tmpjomcoj 23:12:35 INFO - INFO - File cargo.tar.bz2 not present in local cache folder c:/builds/tooltool_cache 23:12:35 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:12:39 INFO - INFO - File cargo.tar.bz2 fetched from https://api.pub.build.mozilla.org/tooltool/ as c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src\tmp6vjhct 23:12:39 INFO - INFO - File sccache.tar.bz2 not present in local cache folder c:/builds/tooltool_cache 23:12:39 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:12:40 INFO - INFO - File sccache.tar.bz2 fetched from https://api.pub.build.mozilla.org/tooltool/ as c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\src\tmph3ex0f 23:12:40 INFO - INFO - File vs2015u3.zip not present in local cache folder c:/builds/tooltool_cache 23:12:40 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:12:40 INFO - INFO - ...failed to fetch 'vs2015u3.zip' from https://api.pub.build.mozilla.org/tooltool/ 23:12:41 INFO - INFO - File integrity verified, renaming tmpjomcoj to rustc.tar.bz2 23:12:41 INFO - INFO - Updating local cache c:/builds/tooltool_cache... 23:12:41 INFO - INFO - Local cache c:/builds/tooltool_cache updated with rustc.tar.bz2 23:12:41 INFO - INFO - File integrity verified, renaming tmp6vjhct to cargo.tar.bz2 23:12:41 INFO - INFO - Updating local cache c:/builds/tooltool_cache... 23:12:41 INFO - INFO - Local cache c:/builds/tooltool_cache updated with cargo.tar.bz2 23:12:41 INFO - INFO - File integrity verified, renaming tmph3ex0f to sccache.tar.bz2 23:12:41 INFO - INFO - Updating local cache c:/builds/tooltool_cache... 23:12:41 INFO - INFO - Local cache c:/builds/tooltool_cache updated with sccache.tar.bz2 23:12:41 INFO - INFO - untarring "rustc.tar.bz2" 23:12:48 INFO - INFO - untarring "cargo.tar.bz2" 23:12:49 INFO - INFO - untarring "sccache.tar.bz2" 23:12:49 INFO - ERROR - The following files failed: 'vs2015u3.zip' 23:13:18 INFO - retry: Calling with args: (['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'], 300, None, None, False, True), kwargs: {}, attempt #2 23:13:18 INFO - Executing: ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'] 23:13:18 INFO - INFO - File vs2015u3.zip not present in local cache folder c:/builds/tooltool_cache 23:13:18 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:13:19 INFO - INFO - ...failed to fetch 'vs2015u3.zip' from https://api.pub.build.mozilla.org/tooltool/ 23:13:19 INFO - INFO - rm tree: rustc 23:13:19 INFO - INFO - untarring "rustc.tar.bz2" 23:13:27 INFO - INFO - rm tree: cargo 23:13:27 INFO - INFO - untarring "cargo.tar.bz2" 23:13:28 INFO - INFO - rm tree: sccache 23:13:28 INFO - INFO - untarring "sccache.tar.bz2" 23:13:28 INFO - ERROR - The following files failed: 'vs2015u3.zip' 23:14:12 INFO - retry: Calling with args: (['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'], 300, None, None, False, True), kwargs: {}, attempt #3 23:14:12 INFO - Executing: ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'] 23:14:13 INFO - INFO - File vs2015u3.zip not present in local cache folder c:/builds/tooltool_cache 23:14:13 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:14:13 INFO - INFO - ...failed to fetch 'vs2015u3.zip' from https://api.pub.build.mozilla.org/tooltool/ 23:14:13 INFO - INFO - rm tree: rustc 23:14:13 INFO - INFO - untarring "rustc.tar.bz2" 23:14:21 INFO - INFO - rm tree: cargo 23:14:21 INFO - INFO - untarring "cargo.tar.bz2" 23:14:21 INFO - INFO - rm tree: sccache 23:14:22 INFO - INFO - untarring "sccache.tar.bz2" 23:14:22 INFO - ERROR - The following files failed: 'vs2015u3.zip' 23:15:30 INFO - retry: Calling with args: (['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'], 300, None, None, False, True), kwargs: {}, attempt #4 23:15:30 INFO - Executing: ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'] 23:15:31 INFO - INFO - File vs2015u3.zip not present in local cache folder c:/builds/tooltool_cache 23:15:31 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:15:31 INFO - INFO - ...failed to fetch 'vs2015u3.zip' from https://api.pub.build.mozilla.org/tooltool/ 23:15:31 INFO - INFO - rm tree: rustc 23:15:32 INFO - INFO - untarring "rustc.tar.bz2" 23:15:39 INFO - INFO - rm tree: cargo 23:15:40 INFO - INFO - untarring "cargo.tar.bz2" 23:15:40 INFO - INFO - rm tree: sccache 23:15:40 INFO - INFO - untarring "sccache.tar.bz2" 23:15:41 INFO - ERROR - The following files failed: 'vs2015u3.zip' 23:17:23 INFO - retry: Calling with args: (['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'], 300, None, None, False, True), kwargs: {}, attempt #5 23:17:23 INFO - Executing: ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'] 23:17:23 INFO - INFO - File vs2015u3.zip not present in local cache folder c:/builds/tooltool_cache 23:17:23 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:17:24 INFO - INFO - ...failed to fetch 'vs2015u3.zip' from https://api.pub.build.mozilla.org/tooltool/ 23:17:24 INFO - INFO - rm tree: rustc 23:17:24 INFO - INFO - untarring "rustc.tar.bz2" 23:17:32 INFO - INFO - rm tree: cargo 23:17:32 INFO - INFO - untarring "cargo.tar.bz2" 23:17:32 INFO - INFO - rm tree: sccache 23:17:33 INFO - INFO - untarring "sccache.tar.bz2" 23:17:33 INFO - ERROR - The following files failed: 'vs2015u3.zip' 23:20:06 INFO - retry: Calling with args: (['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'], 300, None, None, False, True), kwargs: {}, attempt #6 23:20:06 INFO - Executing: ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'] 23:20:06 INFO - INFO - File vs2015u3.zip not present in local cache folder c:/builds/tooltool_cache 23:20:06 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:20:07 INFO - INFO - ...failed to fetch 'vs2015u3.zip' from https://api.pub.build.mozilla.org/tooltool/ 23:20:07 INFO - INFO - rm tree: rustc 23:20:07 INFO - INFO - untarring "rustc.tar.bz2" 23:20:15 INFO - INFO - rm tree: cargo 23:20:15 INFO - INFO - untarring "cargo.tar.bz2" 23:20:15 INFO - INFO - rm tree: sccache 23:20:16 INFO - INFO - untarring "sccache.tar.bz2" 23:20:16 INFO - ERROR - The following files failed: 'vs2015u3.zip' 23:24:04 INFO - retry: Calling with args: (['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'], 300, None, None, False, True), kwargs: {}, attempt #7 23:24:04 INFO - Executing: ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'] 23:24:04 INFO - INFO - File vs2015u3.zip not present in local cache folder c:/builds/tooltool_cache 23:24:04 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:24:05 INFO - INFO - ...failed to fetch 'vs2015u3.zip' from https://api.pub.build.mozilla.org/tooltool/ 23:24:05 INFO - INFO - rm tree: rustc 23:24:05 INFO - INFO - untarring "rustc.tar.bz2" 23:24:12 INFO - INFO - rm tree: cargo 23:24:13 INFO - INFO - untarring "cargo.tar.bz2" 23:24:13 INFO - INFO - rm tree: sccache 23:24:13 INFO - INFO - untarring "sccache.tar.bz2" 23:24:13 INFO - ERROR - The following files failed: 'vs2015u3.zip' 23:29:14 INFO - retry: Calling with args: (['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'], 300, None, None, False, True), kwargs: {}, attempt #8 23:29:14 INFO - Executing: ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'] 23:29:14 INFO - INFO - File vs2015u3.zip not present in local cache folder c:/builds/tooltool_cache 23:29:14 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:29:15 INFO - INFO - ...failed to fetch 'vs2015u3.zip' from https://api.pub.build.mozilla.org/tooltool/ 23:29:15 INFO - INFO - rm tree: rustc 23:29:15 INFO - INFO - untarring "rustc.tar.bz2" 23:29:22 INFO - INFO - rm tree: cargo 23:29:23 INFO - INFO - untarring "cargo.tar.bz2" 23:29:23 INFO - INFO - rm tree: sccache 23:29:23 INFO - INFO - untarring "sccache.tar.bz2" 23:29:23 INFO - ERROR - The following files failed: 'vs2015u3.zip' 23:34:24 INFO - retry: Calling with args: (['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'], 300, None, None, False, True), kwargs: {}, attempt #9 23:34:24 INFO - Executing: ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'] 23:34:24 INFO - INFO - File vs2015u3.zip not present in local cache folder c:/builds/tooltool_cache 23:34:24 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:34:25 INFO - INFO - ...failed to fetch 'vs2015u3.zip' from https://api.pub.build.mozilla.org/tooltool/ 23:34:25 INFO - INFO - rm tree: rustc 23:34:25 INFO - INFO - untarring "rustc.tar.bz2" 23:34:32 INFO - INFO - rm tree: cargo 23:34:33 INFO - INFO - untarring "cargo.tar.bz2" 23:34:33 INFO - INFO - rm tree: sccache 23:34:33 INFO - INFO - untarring "sccache.tar.bz2" 23:34:33 INFO - ERROR - The following files failed: 'vs2015u3.zip' 23:39:34 INFO - retry: Calling with args: (['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'], 300, None, None, False, True), kwargs: {}, attempt #10 23:39:34 INFO - Executing: ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'] 23:39:34 INFO - INFO - File vs2015u3.zip not present in local cache folder c:/builds/tooltool_cache 23:39:34 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:39:35 INFO - INFO - ...failed to fetch 'vs2015u3.zip' from https://api.pub.build.mozilla.org/tooltool/ 23:39:35 INFO - INFO - rm tree: rustc 23:39:35 INFO - INFO - untarring "rustc.tar.bz2" 23:39:42 INFO - INFO - rm tree: cargo 23:39:42 INFO - INFO - untarring "cargo.tar.bz2" 23:39:43 INFO - INFO - rm tree: sccache 23:39:43 INFO - INFO - untarring "sccache.tar.bz2" 23:39:43 INFO - ERROR - The following files failed: 'vs2015u3.zip' 23:39:43 INFO - retry: Giving up on 23:39:43 INFO - Unable to successfully run ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch', '-c', 'c:/builds/tooltool_cache'] after 10 attempts 23:39:43 ERROR - Return code: 1 23:39:43 ERROR - 1 not in success codes: [0] 23:39:43 WARNING - setting return code to 2 23:39:43 FATAL - Halting on failure while running ['sh', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\tools\\scripts\\tooltool\\tooltool_wrapper.sh', 'c:\\builds\\moz2_slave\\m-beta-w64-add-on-devel-000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'https://api.pub.build.mozilla.org/tooltool/', 'setup.sh', 'c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '-c', '/c/builds/tooltool_cache'] 23:39:43 FATAL - Running post_fatal callback... 23:39:43 FATAL - Exiting 2 23:39:43 INFO - [mozharness: 2017-01-24 07:39:43.825000Z] Finished build step (failed) 23:39:43 INFO - Running post-run listener: _summarize 23:39:43 ERROR - # TBPL FAILURE # 23:39:43 INFO - [mozharness: 2017-01-24 07:39:43.825000Z] FxDesktopBuild summary: 23:39:43 ERROR - # TBPL FAILURE # 23:39:43 INFO - Running post-run listener: copy_logs_to_upload_dir 23:39:43 INFO - Copying logs to upload dir... 23:39:43 INFO - mkdir: c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\build\upload\logs program finished with exit code 2 elapsedTime=2698.632000 ========= master_lag: 0.08 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 44 mins, 58 secs) (at 2017-01-23 23:39:46.333345) ========= ========= Started set props: buildid got_revision comments builduid stage_platform (results: 0, elapsed: 0 secs) (at 2017-01-23 23:39:46.336416) ========= 'bash' '-c' 'for file in `ls -1`; do cat $file; done' in dir c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\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=3144 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-snhTIW4044/agent.4044 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:20170123215343 builduid:bfd32c45eab04c74a269662b5c596776 comments:Bug 1330759 - Part 6: Make the null-termination asserts in nsStringBuffer::ToString into diagnostic asserts. r=froydnj, a=jcristau got_revision:1522cb56a651b62675f392d4064bd4365aac07f4 stage_platform:win64-add-on-devel program finished with exit code 0 elapsedTime=0.140000 buildid: '20170123215343' got_revision: '1522cb56a651b62675f392d4064bd4365aac07f4' comments: 'Bug 1330759 - Part 6: Make the null-termination asserts in nsStringBuffer::ToString into diagnostic asserts. r=froydnj, a=jcristau' builduid: 'bfd32c45eab04c74a269662b5c596776' stage_platform: 'win64-add-on-devel' ========= master_lag: 0.01 ========= ========= Finished set props: buildid got_revision comments builduid stage_platform (results: 0, elapsed: 0 secs) (at 2017-01-23 23:39:46.485787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:39:46.486770) ========= 'rm' '-f' 'oauth.txt' in dir c:\builds\moz2_slave\m-beta-w64-add-on-devel-000000\. (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=3144 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-snhTIW4044/agent.4044 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.108000 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:39:46.602365) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2017-01-23 23:39:46.603318) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2017-01-23 23:39:46.847963) ========= ========= Total master_lag: 0.14 =========