builder: autoland-win32-debug
slave: b-2008-spot-057
starttime: 1494531547.32
results: failure (2)
buildid: 20170511122625
builduid: 46d47989ca974a39a8633424fb4d42d5
revision: 508966268fab932a33c9c77be039b6a1b8d3d4ec

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:07.325283) =========
master: http://buildbot-master94.bb.releng.use1.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:07.325720) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:07.326019) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:07.784461) =========

========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-05-11 12:39:07.784799) =========
'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\autoland-w32-d-000000000000000\. (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-057
  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-057
  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:\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 63 Stepping 2, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3f02
  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=3556
  SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620
  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-057
  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-05-11 12:39:09--  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% 7.23K=1.6s

2017-05-11 12:39:12 (7.23 KB/s) - 'archiver_client.py' saved [12179/12179]

program finished with exit code 0
elapsedTime=6.347000
========= master_lag: 0.16 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-05-11 12:39:14.295540) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:14.296486) =========
'rm' '-rf' 'scripts' 'properties'
 in dir c:\builds\moz2_slave\autoland-w32-d-000000000000000\. (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-057
  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-057
  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:\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 63 Stepping 2, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3f02
  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=3556
  SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620
  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-057
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\
  VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\
  VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\
  WINDIR=C:\Windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
  WIX_351728_PATH=c:/mozilla-build/wix-351728
  _=C:\mozilla-build\buildbotve\Scripts\python
 using PTY: False
program finished with exit code 0
elapsedTime=0.106000
========= master_lag: 0.01 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:14.410312) =========

========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2017-05-11 12:39:14.411256) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/autoland --rev 508966268fab932a33c9c77be039b6a1b8d3d4ec --destination scripts --debug'
 in dir c:\builds\moz2_slave\autoland-w32-d-000000000000000\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 508966268fab932a33c9c77be039b6a1b8d3d4ec --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-057
  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-057
  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:\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 63 Stepping 2, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3f02
  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=3556
  SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620
  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-057
  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-05-11 12:39:12,756 truncating revision to first 12 chars
2017-05-11 12:39:12,756 Setting DEBUG logging.
2017-05-11 12:39:12,756 attempt 1/10
2017-05-11 12:39:12,756 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/508966268fab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-05-11 12:39:14,243 unpacking tar archive at: autoland-508966268fab/testing/mozharness/
2017-05-11 12:39:16,184 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=8.346000
========= master_lag: 0.10 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2017-05-11 12:39:22.853177) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:22.854102) =========
script_repo_revision: 508966268fab932a33c9c77be039b6a1b8d3d4ec
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:22.854493) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:22.854766) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:22.863604) =========

========= Started remove old nonce (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:22.863884) =========
'rm' '-f' 'nonce'
 in dir c:\builds\moz2_slave\autoland-w32-d-000000000000000\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-f', 'nonce']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv
  BUILDBOT_PATH=C:\mozilla-build\buildbotve
  CHOCOLATEYINSTALL=C:\ProgramData\chocolatey
  COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
  COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
  COMMONPROGRAMW6432=C:\Program Files\Common Files
  COMPUTERNAME=B-2008-SPOT-057
  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-057
  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:\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 63 Stepping 2, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3f02
  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=3556
  SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620
  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-057
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\
  VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\
  VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\
  WINDIR=C:\Windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
  WIX_351728_PATH=c:/mozilla-build/wix-351728
  _=C:\mozilla-build\buildbotve\Scripts\python
 using PTY: False
program finished with exit code 0
elapsedTime=0.106000
========= master_lag: 0.01 =========
========= Finished remove old nonce (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:22.977383) =========

========= Started downloading to token (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:22.978283) =========
Slave: b-2008-spot-057
IP: 10.134.53.59
Duration: 25200
URI: https://mac-v2-signing2.srv.releng.scl3.mozilla.com:9110/token
========= Finished downloading to token (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:23.469377) =========

========= Started set props: toolsdir (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:23.469780) =========
'bash' '-c' 'pwd'
 in dir c:\builds\moz2_slave\autoland-w32-d-000000000000000\scripts (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'pwd']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv
  BUILDBOT_PATH=C:\mozilla-build\buildbotve
  CHOCOLATEYINSTALL=C:\ProgramData\chocolatey
  COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
  COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
  COMMONPROGRAMW6432=C:\Program Files\Common Files
  COMPUTERNAME=B-2008-SPOT-057
  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-057
  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:\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 63 Stepping 2, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3f02
  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=3556
  SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620
  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-057
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\
  VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\
  VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\
  WINDIR=C:\Windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
  WIX_351728_PATH=c:/mozilla-build/wix-351728
  _=C:\mozilla-build\buildbotve\Scripts\python
 using PTY: False
/c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts
program finished with exit code 0
elapsedTime=0.106000
toolsdir: '/c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts'
========= master_lag: 0.01 =========
========= Finished set props: toolsdir (results: 0, elapsed: 0 secs) (at 2017-05-11 12:39:23.584094) =========

========= Started 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 23 mins, 11 secs) (at 2017-05-11 12:39:23.584964) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/fx_desktop_build.py' '--config' 'builds/releng_base_windows_32_builds.py' '--custom-build-variant-cfg' 'debug' '--config' 'balrog/production.py' '--branch' 'autoland' '--build-pool' 'production'
 in dir c:\builds\moz2_slave\autoland-w32-d-000000000000000\. (timeout 10800 secs) (maxTime 27000 secs)
 watching logfiles {}
 argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/fx_desktop_build.py', '--config', 'builds/releng_base_windows_32_builds.py', '--custom-build-variant-cfg', 'debug', '--config', 'balrog/production.py', '--branch', 'autoland', '--build-pool', 'production']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv
  BINSCOPE=C:\Program Files (x86)\Microsoft\SDL BinScope\BinScope.exe
  BUILDBOT_PATH=C:\mozilla-build\buildbotve
  CHOCOLATEYINSTALL=C:\ProgramData\chocolatey
  COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
  COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
  COMMONPROGRAMW6432=C:\Program Files\Common Files
  COMPUTERNAME=B-2008-SPOT-057
  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-057
  MACHTYPE=i686-pc-msys
  MAKE_MODE=unix
  MOZBUILDDIR=C:\mozilla-build
  MOZILLABUILD=C:\mozilla-build
  MOZ_AUTOMATION=1
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_OBJDIR=obj-firefox
  MOZ_SIGNING_SERVERS=gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110
  MOZ_SIGN_CMD=python /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/autoland-w32-d-000000000000000/signing_cache -t /c/builds/moz2_slave/autoland-w32-d-000000000000000/token -n /c/builds/moz2_slave/autoland-w32-d-000000000000000/nonce -c /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110
  MOZ_TOOLS=C:\mozilla-build\moztools-x64
  MSYSTEM=MINGW32
  NUMBER_OF_PROCESSORS=16
  OLDPWD=c:/Users/cltbld
  OS=Windows_NT
  OSTYPE=msys
  OS_VERSION=2008
  PATH=C:\mozilla-build\nsis-3.0b1;C:\mozilla-build\nsis-2.46u;C:\mozilla-build\python27;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\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 63 Stepping 2, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3f02
  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/autoland-w32-d-000000000000000/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=3556
  SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620
  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-057
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  VS100COMNTOOLS=c:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\Tools\
  VS110COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\Tools\
  VS120COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\Tools\
  WINDIR=C:\Windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
  WIX_351728_PATH=c:/mozilla-build/wix-351728
  XPCOM_DEBUG_BREAK=stack-and-abort
  _=C:\mozilla-build\buildbotve\Scripts\python
 using PTY: False
12:39:24     INFO - MultiFileLogger online at 20170511 12:39:24 in c:\builds\moz2_slave\autoland-w32-d-000000000000000
12:39:24     INFO - Script was run with '--custom-build-variant-cfg debug' and 'debug' matches a key in 'builds/releng_sub_windows_configs/32_debug.py'. Updating self.config with items from that key's value.
12:39:24     INFO - Script was run with '--branch autoland' and 'autoland' matches a key in 'builds/branch_specifics.py'. Updating self.config with items from that key's value.
12:39:24     INFO - Script was run with '--build-pool production' and 'production' matches a key in 'builds/build_pool_specifics.py'. Updating self.config with items from that key's value.
12:39:24     INFO - To generate a config file based upon options passed and config files used, run script as before but extend options with "--dump-config"
12:39:24     INFO - For a diff of where self.config got its items, run the script again as before but extend options with: "--dump-config-hierarchy"
12:39:24     INFO - Both --dump-config and --dump-config-hierarchy don't actually run any actions.
12:39:24     INFO - We are running this in buildbot, grab the build props
12:39:24     INFO - Using buildbot properties:
12:39:24     INFO - {
12:39:24     INFO -     "project": "", 
12:39:24     INFO -     "product": "firefox", 
12:39:24     INFO -     "script_repo_revision": "production", 
12:39:24     INFO -     "scheduler": "autoland-firefox", 
12:39:24     INFO -     "repository": "", 
12:39:24     INFO -     "buildername": "WINNT 5.2 autoland leak test build", 
12:39:24     INFO -     "buildid": "20170511122625", 
12:39:24     INFO -     "basedir": "/c/builds/moz2_slave/autoland-w32-d-000000000000000", 
12:39:24     INFO -     "buildnumber": 1143, 
12:39:24     INFO -     "platform": "win32-debug", 
12:39:24     INFO -     "master": "http://buildbot-master94.bb.releng.use1.mozilla.com:8001/", 
12:39:24     INFO -     "branch": "autoland", 
12:39:24     INFO -     "revision": "508966268fab932a33c9c77be039b6a1b8d3d4ec", 
12:39:24     INFO -     "slavename": "b-2008-spot-057", 
12:39:24     INFO -     "builduid": "46d47989ca974a39a8633424fb4d42d5", 
12:39:24     INFO -     "repo_path": "integration/autoland"
12:39:24     INFO - }
12:39:24     INFO - Setting buildbot property stage_platform to win32-debug
12:39:24     INFO - mkdir: c:\builds\moz2_slave\autoland-w32-d-000000000000000\properties
12:39:24     INFO - Writing buildbot properties ['stage_platform'] to c:\builds\moz2_slave\autoland-w32-d-000000000000000\properties\stage_platform
12:39:24     INFO - Writing to file c:\builds\moz2_slave\autoland-w32-d-000000000000000\properties\stage_platform
12:39:24     INFO - Contents:
12:39:24     INFO -  stage_platform:win32-debug
12:39:24  WARNING - Try message not found.
12:39:24     INFO - Run as scripts/scripts/fx_desktop_build.py --config builds/releng_base_windows_32_builds.py --custom-build-variant-cfg debug --config balrog/production.py --branch autoland --build-pool production
12:39:24     INFO - Determining buildid from buildbot properties
12:39:24     INFO - Setting buildbot property buildid to 20170511122625
12:39:24     INFO - Writing buildbot properties ['buildid'] to c:\builds\moz2_slave\autoland-w32-d-000000000000000\properties\buildid
12:39:24     INFO - Writing to file c:\builds\moz2_slave\autoland-w32-d-000000000000000\properties\buildid
12:39:24     INFO - Contents:
12:39:24     INFO -  buildid:20170511122625
12:39:24     INFO - Determining builduid from buildbot properties
12:39:24     INFO - Setting buildbot property builduid to 46d47989ca974a39a8633424fb4d42d5
12:39:24     INFO - Writing buildbot properties ['builduid'] to c:\builds\moz2_slave\autoland-w32-d-000000000000000\properties\builduid
12:39:24     INFO - Writing to file c:\builds\moz2_slave\autoland-w32-d-000000000000000\properties\builduid
12:39:24     INFO - Contents:
12:39:24     INFO -  builduid:46d47989ca974a39a8633424fb4d42d5
12:39:24     INFO - Creating virtualenv c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv
12:39:24     INFO - mkdir: c:\builds\moz2_slave\autoland-w32-d-000000000000000\build
12:39:24     INFO - Running command: ['c:\\mozilla-build\\python27\\python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\venv'] in c:\builds\moz2_slave\autoland-w32-d-000000000000000\build
12:39:24     INFO - Copy/paste: c:\mozilla-build\python27\python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv
12:39:35     INFO -  The --no-site-packages flag is deprecated; it is now the default behavior.
12:39:35     INFO -  New python executable in c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv\Scripts\python.exe
12:39:43     INFO -  Installing distribute................................................................................................................................................................................................done.
12:40:01     INFO -  Installing pip....................................done.
12:40:01     INFO - Return code: 0
12:40:01     INFO - Getting output from command: ['c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\venv\\Scripts\\pip', '--version']
12:40:01     INFO - Copy/paste: c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv\Scripts\pip --version
12:40:07     INFO - Reading from file tmpfile_stdout
12:40:07     INFO - Output received:
12:40:07     INFO -  pip 9.0.1 from c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv\lib\site-packages\pip-9.0.1-py2.7.egg (python 2.7)
12:40:07     INFO - Using _rmtree_windows ...
12:40:07     INFO - Using _rmtree_windows ...
12:40:07     INFO - Installing requests==2.8.1 into virtualenv c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv
12:40:07     INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\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 0x02314D10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02C251B0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024471B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x026C3990>, '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 0x02613398>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02350E30>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build', 'env': {'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 'SYSTEMROOT': 'C:\\Windows', 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 'SHELL': 'C:/mozilla-build/msys/bin/sh', 'IDLEIZER_HALT_ON_IDLE': 'true', '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', 'WINDOWS_TRACING_FLAGS': '3', 'TOOLTOOL_HOME': '/c/builds', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 'PROCESSOR_LEVEL': '6', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'MOZ_AUTOMATION': '1', 'CVS_RSH': 'ssh', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 'SHLVL': '1', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 'EDITOR': 'emacs.exe', 'HOMEPATH': '\\', 'MOZBUILDDIR': 'C:\\mozilla-build', 'MOZILLABUILD': 'C:\\mozilla-build', 'LOGONSERVER': '\\\\B-2008-SPOT-057', 'OS_VERSION': '2008', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'COMPUTERNAME': 'B-2008-SPOT-057', 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 'USERDOMAIN': 'B-2008-SPOT-057', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'TOOLTOOL_CACHE': 'c:/builds/tooltool_cache', 'HOME': 'c:/Users/cltbld', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'PROCESSOR_ARCHITECTURE': 'x86', 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'OSTYPE': 'msys', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'PROMPT': '$P$G', 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'WINDIR': 'C:\\Windows', 'MOZBUILD_STATE_PATH': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\.mozbuild', 'NUMBER_OF_PROCESSORS': '16', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'PUBLIC': 'C:\\Users\\Public', 'USERPROFILE': 'C:\\Users\\cltbld', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'LOG': '"c:\\runner\\buildbot-startup.log"', 'HOSTTYPE': 'i686', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel', 'LOGNAME': 'cltbld', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '3f02', 'PATH': 'C:/mozilla-build/nsis-3.01;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:\\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', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'SSH_AGENT_PID': '3556', 'MAKE_MODE': 'unix', 'TERM': 'cygwin', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'MSYSTEM': 'MINGW32', 'PROGRAMDATA': 'C:\\ProgramData', 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620', 'TINDERBOX_OUTPUT': '1', 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/autoland-w32-d-000000000000000/signing_cache -t /c/builds/moz2_slave/autoland-w32-d-000000000000000/token -n /c/builds/moz2_slave/autoland-w32-d-000000000000000/nonce -c /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'FP_NO_HOST_CHECK': 'NO', 'OLDPWD': 'c:/Users/cltbld', 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 'PWD': 'c:/Users/cltbld', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files'}}, attempt #1
12:40:07     INFO - Running command: ['c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'requests==2.8.1'] in c:\builds\moz2_slave\autoland-w32-d-000000000000000\build
12:40:07     INFO - Copy/paste: c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv\Scripts\pip install --timeout 120 requests==2.8.1
12:40:07     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:40:07     INFO -  'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
12:40:07     INFO -  'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv',
12:40:07     INFO -  'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe',
12:40:07     INFO -  'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve',
12:40:07     INFO -  'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey',
12:40:07     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:40:07     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:40:07     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:40:07     INFO -  'COMPUTERNAME': 'B-2008-SPOT-057',
12:40:07     INFO -  'COMSPEC': 'C:\\Windows\\system32\\cmd.exe',
12:40:07     INFO -  'CVS_RSH': 'ssh',
12:40:07     INFO -  'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\',
12:40:07     INFO -  'EDITOR': 'emacs.exe',
12:40:07     INFO -  'FP_NO_HOST_CHECK': 'NO',
12:40:07     INFO -  'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared',
12:40:07     INFO -  'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared',
12:40:07     INFO -  'HOME': 'c:/Users/cltbld',
12:40:07     INFO -  'HOMEDRIVE': 'C:',
12:40:07     INFO -  'HOMEPATH': '\\',
12:40:07     INFO -  'HOSTTYPE': 'i686',
12:40:07     INFO -  'IDLEIZER_HALT_ON_IDLE': 'true',
12:40:07     INFO -  'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc',
12:40:07     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
12:40:07     INFO -  'LOG': '"c:\\runner\\buildbot-startup.log"',
12:40:07     INFO -  'LOGNAME': 'cltbld',
12:40:07     INFO -  'LOGONSERVER': '\\\\B-2008-SPOT-057',
12:40:07     INFO -  'MACHTYPE': 'i686-pc-msys',
12:40:07     INFO -  'MAKE_MODE': 'unix',
12:40:07     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build',
12:40:07     INFO -  'MOZBUILD_STATE_PATH': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\.mozbuild',
12:40:07     INFO -  'MOZILLABUILD': 'C:\\mozilla-build',
12:40:07     INFO -  'MOZ_AUTOMATION': '1',
12:40:07     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:40:07     INFO -  'MOZ_OBJDIR': 'obj-firefox',
12:40:07     INFO -  'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110',
12:40:07     INFO -  'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/autoland-w32-d-000000000000000/signing_cache -t /c/builds/moz2_slave/autoland-w32-d-000000000000000/token -n /c/builds/moz2_slave/autoland-w32-d-000000000000000/nonce -c /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110',
12:40:07     INFO -  'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64',
12:40:07     INFO -  'MSYSTEM': 'MINGW32',
12:40:07     INFO -  'NUMBER_OF_PROCESSORS': '16',
12:40:07     INFO -  'OLDPWD': 'c:/Users/cltbld',
12:40:07     INFO -  'OS': 'Windows_NT',
12:40:07     INFO -  'OSTYPE': 'msys',
12:40:07     INFO -  'OS_VERSION': '2008',
12:40:07     INFO -  'PATH': 'C:/mozilla-build/nsis-3.01;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:\\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',
12:40:07     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:40:07     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
12:40:07     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
12:40:07     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel',
12:40:07     INFO -  'PROCESSOR_LEVEL': '6',
12:40:07     INFO -  'PROCESSOR_REVISION': '3f02',
12:40:07     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
12:40:07     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
12:40:07     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:40:07     INFO -  'PROGRAMW6432': 'C:\\Program Files',
12:40:07     INFO -  'PROMPT': '$P$G',
12:40:07     INFO -  'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\buildprops.json',
12:40:07     INFO -  'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ',
12:40:07     INFO -  'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\',
12:40:07     INFO -  'PUBLIC': 'C:\\Users\\Public',
12:40:07     INFO -  'PWD': 'c:/Users/cltbld',
12:40:07     INFO -  'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg',
12:40:07     INFO -  'SHELL': 'C:/mozilla-build/msys/bin/sh',
12:40:07     INFO -  'SHLVL': '1',
12:40:07     INFO -  'SSH_AGENT_PID': '3556',
12:40:07     INFO -  'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620',
12:40:07     INFO -  'SYSTEMDRIVE': 'C:',
12:40:07     INFO -  'SYSTEMROOT': 'C:\\Windows',
12:40:07     INFO -  'TEMP': 'C:/Users/cltbld/AppData/Local/Temp',
12:40:07     INFO -  'TERM': 'cygwin',
12:40:07     INFO -  'TINDERBOX_OUTPUT': '1',
12:40:07     INFO -  'TMP': 'C:/Users/cltbld/AppData/Local/Temp',
12:40:07     INFO -  'TOOLTOOL_CACHE': 'c:/builds/tooltool_cache',
12:40:07     INFO -  'TOOLTOOL_HOME': '/c/builds',
12:40:07     INFO -  'USERDOMAIN': 'B-2008-SPOT-057',
12:40:07     INFO -  'USERNAME': 'cltbld',
12:40:07     INFO -  'USERPROFILE': 'C:\\Users\\cltbld',
12:40:07     INFO -  'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\',
12:40:07     INFO -  'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\',
12:40:07     INFO -  'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\',
12:40:07     INFO -  'WINDIR': 'C:\\Windows',
12:40:07     INFO -  'WINDOWS_TRACING_FLAGS': '3',
12:40:07     INFO -  'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
12:40:07     INFO -  'WIX_351728_PATH': 'c:/mozilla-build/wix-351728',
12:40:07     INFO -  'XPCOM_DEBUG_BREAK': 'stack-and-abort',
12:40:07     INFO -  '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'}
12:40:07     INFO -  Collecting requests==2.8.1
12:40:09     INFO -    Downloading requests-2.8.1-py2.py3-none-any.whl (497kB)
12:40:10     INFO -  Installing collected packages: requests
12:40:10     INFO -  Successfully installed requests-2.8.1
12:40:12     INFO -  c:\builds\moz2_slave\autoland-w32-d-000000000000000\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.
12:40:12     INFO -    SNIMissingWarning
12:40:12     INFO -  c:\builds\moz2_slave\autoland-w32-d-000000000000000\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.
12:40:12     INFO -    InsecurePlatformWarning
12:40:12     INFO -  c:\builds\moz2_slave\autoland-w32-d-000000000000000\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.
12:40:12     INFO -    InsecurePlatformWarning
12:40:12     INFO - Return code: 0
12:40:12     INFO - Installing PyHawk-with-a-single-extra-commit==0.1.5 into virtualenv c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv
12:40:12     INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\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 0x02314D10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02C251B0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024471B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x026C3990>, '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 0x02613398>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02350E30>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build', 'env': {'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 'SYSTEMROOT': 'C:\\Windows', 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 'SHELL': 'C:/mozilla-build/msys/bin/sh', 'IDLEIZER_HALT_ON_IDLE': 'true', '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', 'WINDOWS_TRACING_FLAGS': '3', 'TOOLTOOL_HOME': '/c/builds', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 'PROCESSOR_LEVEL': '6', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'MOZ_AUTOMATION': '1', 'CVS_RSH': 'ssh', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 'SHLVL': '1', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 'EDITOR': 'emacs.exe', 'HOMEPATH': '\\', 'MOZBUILDDIR': 'C:\\mozilla-build', 'MOZILLABUILD': 'C:\\mozilla-build', 'LOGONSERVER': '\\\\B-2008-SPOT-057', 'OS_VERSION': '2008', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'COMPUTERNAME': 'B-2008-SPOT-057', 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 'USERDOMAIN': 'B-2008-SPOT-057', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'TOOLTOOL_CACHE': 'c:/builds/tooltool_cache', 'HOME': 'c:/Users/cltbld', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'PROCESSOR_ARCHITECTURE': 'x86', 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'OSTYPE': 'msys', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'PROMPT': '$P$G', 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'WINDIR': 'C:\\Windows', 'MOZBUILD_STATE_PATH': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\.mozbuild', 'NUMBER_OF_PROCESSORS': '16', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'PUBLIC': 'C:\\Users\\Public', 'USERPROFILE': 'C:\\Users\\cltbld', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'LOG': '"c:\\runner\\buildbot-startup.log"', 'HOSTTYPE': 'i686', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel', 'LOGNAME': 'cltbld', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '3f02', 'PATH': 'C:/mozilla-build/nsis-3.01;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:\\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', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'SSH_AGENT_PID': '3556', 'MAKE_MODE': 'unix', 'TERM': 'cygwin', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'MSYSTEM': 'MINGW32', 'PROGRAMDATA': 'C:\\ProgramData', 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620', 'TINDERBOX_OUTPUT': '1', 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/autoland-w32-d-000000000000000/signing_cache -t /c/builds/moz2_slave/autoland-w32-d-000000000000000/token -n /c/builds/moz2_slave/autoland-w32-d-000000000000000/nonce -c /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'FP_NO_HOST_CHECK': 'NO', 'OLDPWD': 'c:/Users/cltbld', 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 'PWD': 'c:/Users/cltbld', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files'}}, attempt #1
12:40:12     INFO - Running command: ['c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'PyHawk-with-a-single-extra-commit==0.1.5'] in c:\builds\moz2_slave\autoland-w32-d-000000000000000\build
12:40:12     INFO - Copy/paste: c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv\Scripts\pip install --timeout 120 PyHawk-with-a-single-extra-commit==0.1.5
12:40:12     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:40:12     INFO -  'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
12:40:12     INFO -  'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv',
12:40:12     INFO -  'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe',
12:40:12     INFO -  'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve',
12:40:12     INFO -  'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey',
12:40:12     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:40:12     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:40:12     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:40:12     INFO -  'COMPUTERNAME': 'B-2008-SPOT-057',
12:40:12     INFO -  'COMSPEC': 'C:\\Windows\\system32\\cmd.exe',
12:40:12     INFO -  'CVS_RSH': 'ssh',
12:40:12     INFO -  'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\',
12:40:12     INFO -  'EDITOR': 'emacs.exe',
12:40:12     INFO -  'FP_NO_HOST_CHECK': 'NO',
12:40:12     INFO -  'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared',
12:40:12     INFO -  'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared',
12:40:12     INFO -  'HOME': 'c:/Users/cltbld',
12:40:12     INFO -  'HOMEDRIVE': 'C:',
12:40:12     INFO -  'HOMEPATH': '\\',
12:40:12     INFO -  'HOSTTYPE': 'i686',
12:40:12     INFO -  'IDLEIZER_HALT_ON_IDLE': 'true',
12:40:12     INFO -  'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc',
12:40:12     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
12:40:12     INFO -  'LOG': '"c:\\runner\\buildbot-startup.log"',
12:40:12     INFO -  'LOGNAME': 'cltbld',
12:40:12     INFO -  'LOGONSERVER': '\\\\B-2008-SPOT-057',
12:40:12     INFO -  'MACHTYPE': 'i686-pc-msys',
12:40:12     INFO -  'MAKE_MODE': 'unix',
12:40:12     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build',
12:40:12     INFO -  'MOZBUILD_STATE_PATH': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\.mozbuild',
12:40:12     INFO -  'MOZILLABUILD': 'C:\\mozilla-build',
12:40:12     INFO -  'MOZ_AUTOMATION': '1',
12:40:12     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:40:12     INFO -  'MOZ_OBJDIR': 'obj-firefox',
12:40:12     INFO -  'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110',
12:40:12     INFO -  'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/autoland-w32-d-000000000000000/signing_cache -t /c/builds/moz2_slave/autoland-w32-d-000000000000000/token -n /c/builds/moz2_slave/autoland-w32-d-000000000000000/nonce -c /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110',
12:40:12     INFO -  'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64',
12:40:12     INFO -  'MSYSTEM': 'MINGW32',
12:40:12     INFO -  'NUMBER_OF_PROCESSORS': '16',
12:40:12     INFO -  'OLDPWD': 'c:/Users/cltbld',
12:40:12     INFO -  'OS': 'Windows_NT',
12:40:12     INFO -  'OSTYPE': 'msys',
12:40:12     INFO -  'OS_VERSION': '2008',
12:40:12     INFO -  'PATH': 'C:/mozilla-build/nsis-3.01;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:\\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',
12:40:12     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:40:12     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
12:40:12     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
12:40:12     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel',
12:40:12     INFO -  'PROCESSOR_LEVEL': '6',
12:40:12     INFO -  'PROCESSOR_REVISION': '3f02',
12:40:12     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
12:40:12     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
12:40:12     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:40:12     INFO -  'PROGRAMW6432': 'C:\\Program Files',
12:40:12     INFO -  'PROMPT': '$P$G',
12:40:12     INFO -  'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\buildprops.json',
12:40:12     INFO -  'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ',
12:40:12     INFO -  'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\',
12:40:12     INFO -  'PUBLIC': 'C:\\Users\\Public',
12:40:12     INFO -  'PWD': 'c:/Users/cltbld',
12:40:12     INFO -  'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg',
12:40:12     INFO -  'SHELL': 'C:/mozilla-build/msys/bin/sh',
12:40:12     INFO -  'SHLVL': '1',
12:40:12     INFO -  'SSH_AGENT_PID': '3556',
12:40:12     INFO -  'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620',
12:40:12     INFO -  'SYSTEMDRIVE': 'C:',
12:40:12     INFO -  'SYSTEMROOT': 'C:\\Windows',
12:40:12     INFO -  'TEMP': 'C:/Users/cltbld/AppData/Local/Temp',
12:40:12     INFO -  'TERM': 'cygwin',
12:40:12     INFO -  'TINDERBOX_OUTPUT': '1',
12:40:12     INFO -  'TMP': 'C:/Users/cltbld/AppData/Local/Temp',
12:40:12     INFO -  'TOOLTOOL_CACHE': 'c:/builds/tooltool_cache',
12:40:12     INFO -  'TOOLTOOL_HOME': '/c/builds',
12:40:12     INFO -  'USERDOMAIN': 'B-2008-SPOT-057',
12:40:12     INFO -  'USERNAME': 'cltbld',
12:40:12     INFO -  'USERPROFILE': 'C:\\Users\\cltbld',
12:40:12     INFO -  'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\',
12:40:12     INFO -  'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\',
12:40:12     INFO -  'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\',
12:40:12     INFO -  'WINDIR': 'C:\\Windows',
12:40:12     INFO -  'WINDOWS_TRACING_FLAGS': '3',
12:40:12     INFO -  'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
12:40:12     INFO -  'WIX_351728_PATH': 'c:/mozilla-build/wix-351728',
12:40:12     INFO -  'XPCOM_DEBUG_BREAK': 'stack-and-abort',
12:40:12     INFO -  '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'}
12:40:12     INFO -  Collecting PyHawk-with-a-single-extra-commit==0.1.5
12:40:13     INFO -    Downloading PyHawk-with-a-single-extra-commit-0.1.5.tar.gz
12:40:14     INFO -  Installing collected packages: PyHawk-with-a-single-extra-commit
12:40:14     INFO -    Running setup.py install for PyHawk-with-a-single-extra-commit: started
12:40:14     INFO -      Running setup.py install for PyHawk-with-a-single-extra-commit: finished with status 'done'
12:40:14     INFO -  Successfully installed PyHawk-with-a-single-extra-commit-0.1.5
12:40:14     INFO -  c:\builds\moz2_slave\autoland-w32-d-000000000000000\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.
12:40:14     INFO -    SNIMissingWarning
12:40:14     INFO -  c:\builds\moz2_slave\autoland-w32-d-000000000000000\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.
12:40:14     INFO -    InsecurePlatformWarning
12:40:14     INFO - Return code: 0
12:40:14     INFO - Installing taskcluster==0.0.26 into virtualenv c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv
12:40:14     INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\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 0x02314D10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02C251B0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024471B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x026C3990>, '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 0x02613398>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02350E30>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build', 'env': {'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe', 'SYSTEMROOT': 'C:\\Windows', 'XPCOM_DEBUG_BREAK': 'stack-and-abort', 'SHELL': 'C:/mozilla-build/msys/bin/sh', 'IDLEIZER_HALT_ON_IDLE': 'true', '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', 'WINDOWS_TRACING_FLAGS': '3', 'TOOLTOOL_HOME': '/c/builds', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 'PROCESSOR_LEVEL': '6', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'MOZ_AUTOMATION': '1', 'CVS_RSH': 'ssh', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 'SHLVL': '1', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 'EDITOR': 'emacs.exe', 'HOMEPATH': '\\', 'MOZBUILDDIR': 'C:\\mozilla-build', 'MOZILLABUILD': 'C:\\mozilla-build', 'LOGONSERVER': '\\\\B-2008-SPOT-057', 'OS_VERSION': '2008', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'COMPUTERNAME': 'B-2008-SPOT-057', 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 'USERDOMAIN': 'B-2008-SPOT-057', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'TOOLTOOL_CACHE': 'c:/builds/tooltool_cache', 'HOME': 'c:/Users/cltbld', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'PROCESSOR_ARCHITECTURE': 'x86', 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'OSTYPE': 'msys', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'PROMPT': '$P$G', 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'WINDIR': 'C:\\Windows', 'MOZBUILD_STATE_PATH': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\.mozbuild', 'NUMBER_OF_PROCESSORS': '16', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'PUBLIC': 'C:\\Users\\Public', 'USERPROFILE': 'C:\\Users\\cltbld', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'LOG': '"c:\\runner\\buildbot-startup.log"', 'HOSTTYPE': 'i686', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel', 'LOGNAME': 'cltbld', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '3f02', 'PATH': 'C:/mozilla-build/nsis-3.01;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:\\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', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'SSH_AGENT_PID': '3556', 'MAKE_MODE': 'unix', 'TERM': 'cygwin', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'MSYSTEM': 'MINGW32', 'PROGRAMDATA': 'C:\\ProgramData', 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620', 'TINDERBOX_OUTPUT': '1', 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/autoland-w32-d-000000000000000/signing_cache -t /c/builds/moz2_slave/autoland-w32-d-000000000000000/token -n /c/builds/moz2_slave/autoland-w32-d-000000000000000/nonce -c /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'FP_NO_HOST_CHECK': 'NO', 'OLDPWD': 'c:/Users/cltbld', 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 'PWD': 'c:/Users/cltbld', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files'}}, attempt #1
12:40:14     INFO - Running command: ['c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'taskcluster==0.0.26'] in c:\builds\moz2_slave\autoland-w32-d-000000000000000\build
12:40:14     INFO - Copy/paste: c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv\Scripts\pip install --timeout 120 taskcluster==0.0.26
12:40:14     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
12:40:14     INFO -  'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
12:40:14     INFO -  'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv',
12:40:14     INFO -  'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe',
12:40:14     INFO -  'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve',
12:40:14     INFO -  'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey',
12:40:14     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
12:40:14     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
12:40:14     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
12:40:14     INFO -  'COMPUTERNAME': 'B-2008-SPOT-057',
12:40:14     INFO -  'COMSPEC': 'C:\\Windows\\system32\\cmd.exe',
12:40:14     INFO -  'CVS_RSH': 'ssh',
12:40:14     INFO -  'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\',
12:40:14     INFO -  'EDITOR': 'emacs.exe',
12:40:14     INFO -  'FP_NO_HOST_CHECK': 'NO',
12:40:14     INFO -  'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared',
12:40:14     INFO -  'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared',
12:40:14     INFO -  'HOME': 'c:/Users/cltbld',
12:40:14     INFO -  'HOMEDRIVE': 'C:',
12:40:14     INFO -  'HOMEPATH': '\\',
12:40:14     INFO -  'HOSTTYPE': 'i686',
12:40:14     INFO -  'IDLEIZER_HALT_ON_IDLE': 'true',
12:40:14     INFO -  'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc',
12:40:14     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
12:40:14     INFO -  'LOG': '"c:\\runner\\buildbot-startup.log"',
12:40:14     INFO -  'LOGNAME': 'cltbld',
12:40:14     INFO -  'LOGONSERVER': '\\\\B-2008-SPOT-057',
12:40:14     INFO -  'MACHTYPE': 'i686-pc-msys',
12:40:14     INFO -  'MAKE_MODE': 'unix',
12:40:14     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build',
12:40:14     INFO -  'MOZBUILD_STATE_PATH': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\.mozbuild',
12:40:14     INFO -  'MOZILLABUILD': 'C:\\mozilla-build',
12:40:14     INFO -  'MOZ_AUTOMATION': '1',
12:40:14     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:40:14     INFO -  'MOZ_OBJDIR': 'obj-firefox',
12:40:14     INFO -  'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110',
12:40:14     INFO -  'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/autoland-w32-d-000000000000000/signing_cache -t /c/builds/moz2_slave/autoland-w32-d-000000000000000/token -n /c/builds/moz2_slave/autoland-w32-d-000000000000000/nonce -c /c/builds/moz2_slave/autoland-w32-d-000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110',
12:40:14     INFO -  'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64',
12:40:14     INFO -  'MSYSTEM': 'MINGW32',
12:40:14     INFO -  'NUMBER_OF_PROCESSORS': '16',
12:40:14     INFO -  'OLDPWD': 'c:/Users/cltbld',
12:40:14     INFO -  'OS': 'Windows_NT',
12:40:14     INFO -  'OSTYPE': 'msys',
12:40:14     INFO -  'OS_VERSION': '2008',
12:40:14     INFO -  'PATH': 'C:/mozilla-build/nsis-3.01;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:\\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',
12:40:14     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
12:40:14     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
12:40:14     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
12:40:14     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel',
12:40:14     INFO -  'PROCESSOR_LEVEL': '6',
12:40:14     INFO -  'PROCESSOR_REVISION': '3f02',
12:40:14     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
12:40:14     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
12:40:14     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
12:40:14     INFO -  'PROGRAMW6432': 'C:\\Program Files',
12:40:14     INFO -  'PROMPT': '$P$G',
12:40:14     INFO -  'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\buildprops.json',
12:40:14     INFO -  'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ',
12:40:14     INFO -  'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\',
12:40:14     INFO -  'PUBLIC': 'C:\\Users\\Public',
12:40:14     INFO -  'PWD': 'c:/Users/cltbld',
12:40:14     INFO -  'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg',
12:40:14     INFO -  'SHELL': 'C:/mozilla-build/msys/bin/sh',
12:40:14     INFO -  'SHLVL': '1',
12:40:14     INFO -  'SSH_AGENT_PID': '3556',
12:40:14     INFO -  'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620',
12:40:14     INFO -  'SYSTEMDRIVE': 'C:',
12:40:14     INFO -  'SYSTEMROOT': 'C:\\Windows',
12:40:14     INFO -  'TEMP': 'C:/Users/cltbld/AppData/Local/Temp',
12:40:14     INFO -  'TERM': 'cygwin',
12:40:14     INFO -  'TINDERBOX_OUTPUT': '1',
12:40:14     INFO -  'TMP': 'C:/Users/cltbld/AppData/Local/Temp',
12:40:14     INFO -  'TOOLTOOL_CACHE': 'c:/builds/tooltool_cache',
12:40:14     INFO -  'TOOLTOOL_HOME': '/c/builds',
12:40:14     INFO -  'USERDOMAIN': 'B-2008-SPOT-057',
12:40:14     INFO -  'USERNAME': 'cltbld',
12:40:14     INFO -  'USERPROFILE': 'C:\\Users\\cltbld',
12:40:14     INFO -  'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\',
12:40:14     INFO -  'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\',
12:40:14     INFO -  'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\',
12:40:14     INFO -  'WINDIR': 'C:\\Windows',
12:40:14     INFO -  'WINDOWS_TRACING_FLAGS': '3',
12:40:14     INFO -  'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
12:40:14     INFO -  'WIX_351728_PATH': 'c:/mozilla-build/wix-351728',
12:40:14     INFO -  'XPCOM_DEBUG_BREAK': 'stack-and-abort',
12:40:14     INFO -  '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'}
12:40:15     INFO -  Collecting taskcluster==0.0.26
12:40:16     INFO -    Downloading taskcluster-0.0.26.tar.gz
12:40:16     INFO -  Collecting requests<=2.7.0,>=2.4.3 (from taskcluster==0.0.26)
12:40:16     INFO -    Downloading requests-2.7.0-py2.py3-none-any.whl (470kB)
12:40:17     INFO -  Requirement already satisfied: PyHawk_with_a_single_extra_commit==0.1.5 in .\venv\lib\site-packages (from taskcluster==0.0.26)
12:40:17     INFO -  Collecting slugid (from taskcluster==0.0.26)
12:40:17     INFO -    Downloading slugid-1.0.7.tar.gz
12:40:17     INFO -  Installing collected packages: requests, slugid, taskcluster
12:40:17     INFO -    Found existing installation: requests 2.8.1
12:40:17     INFO -      Uninstalling requests-2.8.1:
12:40:18     INFO -        Successfully uninstalled requests-2.8.1
12:40:19     INFO -    Running setup.py install for slugid: started
12:40:19     INFO -      Running setup.py install for slugid: finished with status 'done'
12:40:19     INFO -    Running setup.py install for taskcluster: started
12:40:20     INFO -      Running setup.py install for taskcluster: finished with status 'done'
12:40:20     INFO -  Successfully installed requests-2.7.0 slugid-1.0.7 taskcluster-0.0.26
12:40:20     INFO -  c:\builds\moz2_slave\autoland-w32-d-000000000000000\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.
12:40:20     INFO -    SNIMissingWarning
12:40:20     INFO -  c:\builds\moz2_slave\autoland-w32-d-000000000000000\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.
12:40:20     INFO -    InsecurePlatformWarning
12:40:20     INFO - Return code: 0
12:40:20     INFO - Done creating virtualenv c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv.
12:40:20     INFO - Getting output from command: ['c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\venv\\Scripts\\pip', 'freeze']
12:40:20     INFO - Copy/paste: c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\venv\Scripts\pip freeze
12:40:21     INFO - Reading from file tmpfile_stdout
12:40:21     INFO - Using _rmtree_windows ...
12:40:21     INFO - Using _rmtree_windows ...
12:40:21     INFO - Current package versions:
12:40:21     INFO -   PyHawk-with-a-single-extra-commit == 0.1.5
12:40:21     INFO -   requests == 2.7.0
12:40:21     INFO -   slugid == 1.0.7
12:40:21     INFO -   taskcluster == 0.0.26
12:40:21     INFO - Running pre-run listener: suppress_windows_modal_dialogs
12:40:21     INFO - Dumping config to c:\builds\moz2_slave\autoland-w32-d-000000000000000\logs\localconfig.json.
12:40:21     INFO - {'app_ini_path': '%(obj_dir)s/dist/bin/application.ini',
12:40:21     INFO -  'append_to_log': False,
12:40:21     INFO -  'balrog_credentials_file': 'oauth.txt',
12:40:21     INFO -  'balrog_servers': ({'balrog_api_root': 'https://aus4-admin.mozilla.org/api',
12:40:21     INFO -                      'balrog_usernames': {'Fennec': 'ffxbld',
12:40:21     INFO -                                           'firefox': 'ffxbld',
12:40:21     INFO -                                           'mobile': 'ffxbld',
12:40:21     INFO -                                           'thunderbird': 'tbirdbld'},
12:40:21     INFO -                      'ignore_failures': False,
12:40:21     INFO -                      'url_replacements': (('http://archive.mozilla.org/pub',
12:40:21     INFO -                                            'http://download.cdn.mozilla.net/pub'),)},),
12:40:21     INFO -  'base_name': 'WINNT_5.2_%(branch)s',
12:40:21     INFO -  'base_work_dir': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000',
12:40:21     INFO -  'branch': 'autoland',
12:40:21     INFO -  'build_pool': 'production',
12:40:21     INFO -  'build_resources_path': '%(abs_src_dir)s/obj-firefox/.mozbuild/build_resources.json',
12:40:21     INFO -  'build_variant': 'debug',
12:40:21     INFO -  'buildbot_json_path': 'buildprops.json',
12:40:21     INFO -  'check_test_env': {'MINIDUMP_SAVE_PATH': '%(base_work_dir)s/minidumps',
12:40:21     INFO -                     'MINIDUMP_STACKWALK': '%(abs_tools_dir)s/breakpad/win32/minidump_stackwalk.exe'},
12:40:21     INFO -  'clobberer_url': 'https://api.pub.build.mozilla.org/clobberer/lastclobber',
12:40:21     INFO -  'clone_by_revision': False,
12:40:21     INFO -  'clone_upstream_url': 'https://hg.mozilla.org/mozilla-unified',
12:40:21     INFO -  'clone_with_purge': False,
12:40:21     INFO -  'config_files': ('builds/releng_base_windows_32_builds.py',
12:40:21     INFO -                   'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\scripts\\scripts\\..\\configs\\builds/releng_sub_windows_configs/32_debug.py',
12:40:21     INFO -                   'balrog/production.py',
12:40:21     INFO -                   'builds/branch_specifics.py',
12:40:21     INFO -                   'builds/build_pool_specifics.py'),
12:40:21     INFO -  'debug_build': True,
12:40:21     INFO -  'default_actions': ('clobber',
12:40:21     INFO -                      'clone-tools',
12:40:21     INFO -                      'checkout-sources',
12:40:21     INFO -                      'build',
12:40:21     INFO -                      'generate-build-stats',
12:40:21     INFO -                      'upload-files',
12:40:21     INFO -                      'sendchange',
12:40:21     INFO -                      'check-test',
12:40:21     INFO -                      'update'),
12:40:21     INFO -  'enable_ccache': False,
12:40:21     INFO -  'enable_count_ctors': False,
12:40:21     INFO -  'enable_signing': True,
12:40:21     INFO -  'enable_talos_sendchange': False,
12:40:21     INFO -  'enable_unittest_sendchange': True,
12:40:21     INFO -  'env': {'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe',
12:40:21     INFO -          'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared',
12:40:21     INFO -          'MOZBUILD_STATE_PATH': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\.mozbuild',
12:40:21     INFO -          'MOZ_CRASHREPORTER_NO_REPORT': '1',
12:40:21     INFO -          'MOZ_OBJDIR': 'obj-firefox',
12:40:21     INFO -          'PATH': 'C:/mozilla-build/nsis-3.01;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:\\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',
12:40:21     INFO -          'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\buildprops.json',
12:40:21     INFO -          'TINDERBOX_OUTPUT': '1',
12:40:21     INFO -          'TOOLTOOL_CACHE': 'c:/builds/tooltool_cache',
12:40:21     INFO -          'TOOLTOOL_HOME': '/c/builds',
12:40:21     INFO -          'XPCOM_DEBUG_BREAK': 'stack-and-abort'},
12:40:21     INFO -  'exes': {'buildbot': ('c:\\mozilla-build\\python27\\python.exe',
12:40:21     INFO -                        'c:\\mozilla-build\\buildbotve\\scripts\\buildbot'),
12:40:21     INFO -           'virtualenv': ('c:\\mozilla-build\\python27\\python.exe',
12:40:21     INFO -                          'c:/mozilla-build/buildbotve/virtualenv.py')},
12:40:21     INFO -  'graph_selector': '/server/collect.cgi',
12:40:21     INFO -  'graph_server': 'graphs.mozilla.org',
12:40:21     INFO -  'include_post_upload_builddir': False,
12:40:21     INFO -  'is_automation': True,
12:40:21     INFO -  'log_level': 'info',
12:40:21     INFO -  'log_to_console': True,
12:40:21     INFO -  'max_build_output_timeout': 4800,
12:40:21     INFO -  'nightly_build': False,
12:40:21     INFO -  'nightly_promotion_branches': ('mozilla-central', 'mozilla-aurora'),
12:40:21     INFO -  'objdir': 'obj-firefox',
12:40:21     INFO -  'old_packages': ('%(objdir)s/dist/firefox-*',
12:40:21     INFO -                   '%(objdir)s/dist/fennec*',
12:40:21     INFO -                   '%(objdir)s/dist/seamonkey*',
12:40:21     INFO -                   '%(objdir)s/dist/thunderbird*',
12:40:21     INFO -                   '%(objdir)s/dist/install/sea/*.exe'),
12:40:21     INFO -  'opt_config_files': (),
12:40:21     INFO -  'periodic_clobber': 168,
12:40:21     INFO -  'pgo_build': False,
12:40:21     INFO -  'pgo_platforms': ('linux', 'linux64', 'win32', 'win64'),
12:40:21     INFO -  'platform': 'win32',
12:40:21     INFO -  'platform_supports_post_upload_to_latest': True,
12:40:21     INFO -  'publish_nightly_en_US_routes': True,
12:40:21     INFO -  'release_to_try_builds': False,
12:40:21     INFO -  'repo_base': 'https://hg.mozilla.org',
12:40:21     INFO -  'repo_path': 'integration/autoland',
12:40:21     INFO -  'scm_level': 1,
12:40:21     INFO -  'sendchange_masters': ('buildbot-master81.build.mozilla.org:9301',),
12:40:21     INFO -  'src_mozconfig': 'browser/config/mozconfigs/win32/debug',
12:40:21     INFO -  'stage_platform': 'win32-debug',
12:40:21     INFO -  'stage_product': 'firefox',
12:40:21     INFO -  'stage_server': 'upload.ffxbld.productdelivery.prod.mozaws.net',
12:40:21     INFO -  'stage_ssh_key': 'ffxbld_rsa',
12:40:21     INFO -  'stage_username': 'ffxbld',
12:40:21     INFO -  'taskcluster_credentials_file': 'oauth.txt',
12:40:21     INFO -  'taskcluster_index': 'index',
12:40:21     INFO -  'tinderbox_build_dir': None,
12:40:21     INFO -  'to_tinderbox_dated': True,
12:40:21     INFO -  'tools_repo': 'https://hg.mozilla.org/build/tools',
12:40:21     INFO -  'tooltool_bootstrap': 'setup.sh',
12:40:21     INFO -  'tooltool_manifest_src': 'browser/config/tooltool-manifests/win32/releng.manifest',
12:40:21     INFO -  'tooltool_script': ('c:\\mozilla-build\\python27\\python.exe',
12:40:21     INFO -                      'C:/mozilla-build/tooltool.py'),
12:40:21     INFO -  'tooltool_url': 'https://api.pub.build.mozilla.org/tooltool/',
12:40:21     INFO -  'upload_env': {'UPLOAD_HOST': '%(stage_server)s',
12:40:21     INFO -                 'UPLOAD_SSH_KEY': '/c/Users/cltbld/.ssh/%(stage_ssh_key)s',
12:40:21     INFO -                 'UPLOAD_TO_TEMP': '1',
12:40:21     INFO -                 'UPLOAD_USER': '%(stage_username)s'},
12:40:21     INFO -  'use_clobberer': True,
12:40:21     INFO -  'vcs_share_base': 'C:/builds/hg-shared',
12:40:21     INFO -  'virtualenv_modules': ('requests==2.8.1',
12:40:21     INFO -                         'PyHawk-with-a-single-extra-commit==0.1.5',
12:40:21     INFO -                         'taskcluster==0.0.26'),
12:40:21     INFO -  'virtualenv_path': 'venv',
12:40:21     INFO -  'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
12:40:21     INFO -  'who': '',
12:40:21     INFO -  'work_dir': 'build'}
12:40:21     INFO - [mozharness: 2017-05-11 19:40:21.320000Z] Skipping get-secrets step.
12:40:21     INFO - [mozharness: 2017-05-11 19:40:21.320000Z] Running clobber step.
12:40:21     INFO - Running main action method: clobber
12:40:21     INFO - retry: Calling run_command with args: [['python', 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\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'autoland', u'WINNT 5.2 autoland leak test build', 'autoland-w32-d-000000000000000', u'b-2008-spot-057', 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
12:40:21     INFO - Running command: ['python', 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\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'autoland', u'WINNT 5.2 autoland leak test build', 'autoland-w32-d-000000000000000', u'b-2008-spot-057', u'http://buildbot-master94.bb.releng.use1.mozilla.com:8001/'] in c:\builds\moz2_slave
12:40:21     INFO - Copy/paste: python c:\builds\moz2_slave\autoland-w32-d-000000000000000\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 autoland "WINNT 5.2 autoland leak test build" autoland-w32-d-000000000000000 b-2008-spot-057 http://buildbot-master94.bb.releng.use1.mozilla.com:8001/
12:40:21     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-057&builddir=autoland-w32-d-000000000000000&branch=autoland&buildername=WINNT+5.2+autoland+leak+test+build
12:40:21     INFO -  autoland-w32-d-000000000000000:Our last clobber date:  None
12:40:21     INFO -  autoland-w32-d-000000000000000:Server clobber date:    None
12:40:21     INFO -  TinderboxPrint: purged clobber
12:40:21     INFO - Return code: 0
12:40:21     INFO - [mozharness: 2017-05-11 19:40:21.984000Z] Finished clobber step (success)
12:40:21     INFO - [mozharness: 2017-05-11 19:40:21.984000Z] Running clone-tools step.
12:40:21     INFO - Running main action method: clone_tools
12:40:21     INFO - retry: Calling _get_revision with args: (<mozharness.base.vcs.mercurial.MercurialVCS object at 0x02678EF0>, 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\tools'), kwargs: {}, attempt #1
12:40:21  WARNING - did not specify revision or branch; assuming "default"
12:40:21     INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version']
12:40:21     INFO - Copy/paste: hg --config ui.merge=internal:merge --version
12:40:28     INFO -  Mercurial Distributed SCM (version 3.9.1)
12:40:28     INFO -  (see https://mercurial-scm.org for more information)
12:40:28     INFO -  Copyright (C) 2005-2016 Matt Mackall and others
12:40:28     INFO -  This is free software; see the source for copying conditions. There is NO
12:40:28     INFO -  warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
12:40:28     INFO - Return code: 0
12:40:28     INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall']
12:40:28     INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall
12:40:29     INFO -  checking encoding (cp1252)...
12:40:29     INFO -  checking Python executable (c:\mozilla-build\hg\hg.exe)
12:40:29     INFO -  checking Python version (2.7.12)
12:40:29     INFO -  checking Python lib (c:\mozilla-build\hg\lib\library.zip)...
12:40:29     INFO -  checking Mercurial version (3.9.1)
12:40:29     INFO -  checking Mercurial custom build ()
12:40:29     INFO -  checking module policy (c)
12:40:29     INFO -  checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)...
12:40:29     INFO -  checking templates (c:\mozilla-build\hg\templates)...
12:40:29     INFO -  checking default template (c:\mozilla-build\hg\templates\map-cmdline.default)
12:40:29     INFO -  checking commit editor... (notepad)
12:40:29     INFO -  checking username (Mozilla Release Engineering <release@mozilla.com>)
12:40:29     INFO -  no problems detected
12:40:29     INFO - Return code: 0
12:40:29     INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/build/tools', 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\tools', '--sharebase', 'C:/builds/hg-shared', '--branch', 'default']
12:40:29     INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\autoland-w32-d-000000000000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/build/tools c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\tools --sharebase C:/builds/hg-shared --branch default
12:40:50     INFO -  
12:40:50     INFO - clone [>                                             ]   738657/30218216 1m22s
12:40:50     INFO - clone [==>                                             ]  2245985/30218216 38s
12:40:50     INFO - clone [========>                                       ]  5998954/30218216 17s
12:40:50     INFO - clone [==============>                                 ]  9568950/30218216 11s
12:40:50     INFO - clone [======================>                         ] 14707147/30218216 07s
12:40:50     INFO - clone [========================>                       ] 16094182/30218216 07s
12:40:50     INFO - clone [=========================>                      ] 16686186/30218216 07s
12:40:50     INFO - clone [==========================>                     ] 17299806/30218216 08s
12:40:50     INFO - clone [===========================>                    ] 17757432/30218216 08s
12:40:50     INFO - clone [=============================>                  ] 19024316/30218216 08s
12:40:50     INFO - clone [==============================>                 ] 19970896/30218216 07s
12:40:50     INFO - clone [==============================>                 ] 19987804/30218216 08s
12:40:50     INFO - clone [========================================>       ] 26355922/30218216 03s
12:40:50     INFO -                                                                                
12:40:50     INFO - ensuring https://hg.mozilla.org/build/tools@default is available at c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\tools
12:40:50     INFO -  (sharing from new pooled repository 7ae7fb134bf7aec6ec96a062ff47a69053dd2973)
12:40:50     INFO -  applying clone bundle from https://s3-external-1.amazonaws.com/moz-hg-bundles-us-east-1/build/tools/64973b395ed7336acdd15624c8aea53959174538.packed1.hg
12:40:50     INFO -  2170 files to transfer, 28.8 MB of data
12:40:50     INFO -  transferred 28.8 MB in 16.8 seconds (1.72 MB/sec)
12:40:50     INFO -  finished applying clone bundle
12:40:50     INFO -  searching for changes
12:40:50     INFO -  adding changesets
12:40:50     INFO -  adding manifests
12:40:50     INFO -  adding file changes
12:40:50     INFO -  added 2 changesets with 4 changes to 3 files
12:40:51     INFO -  searching for changes
12:40:51     INFO -  no changes found
12:40:51     INFO -  (pulling to obtain default)
12:40:51     INFO -  (remote resolved default to 314a14daf2f10131e43671ce9de9e23aa1cd8316; result is not deterministic)
12:40:51     INFO -  (revision already present locally; not pulling)
12:40:56     INFO -  
12:40:56     INFO - updating [====>                                                    ]  100/1046
12:40:56     INFO - updating [==============>                                      ]  300/1046 08s
12:40:56     INFO - updating [=============================>                       ]  600/1046 04s
12:40:56     INFO -                                                                                
12:40:56     INFO - 1046 files updated, 0 files merged, 0 files removed, 0 files unresolved
12:40:56     INFO -  updated to 314a14daf2f10131e43671ce9de9e23aa1cd8316
12:40:56     INFO - Return code: 0
12:40:56     INFO - [mozharness: 2017-05-11 19:40:56.723000Z] Finished clone-tools step (success)
12:40:56     INFO - [mozharness: 2017-05-11 19:40:56.723000Z] Running checkout-sources step.
12:40:56     INFO - Running main action method: checkout_sources
12:40:56     INFO - retry: Calling _get_revision with args: (<mozharness.base.vcs.mercurial.MercurialVCS object at 0x02678EF0>, 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\src'), kwargs: {}, attempt #1
12:40:56     INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version']
12:40:56     INFO - Copy/paste: hg --config ui.merge=internal:merge --version
12:40:56     INFO -  Mercurial Distributed SCM (version 3.9.1)
12:40:56     INFO -  (see https://mercurial-scm.org for more information)
12:40:56     INFO -  Copyright (C) 2005-2016 Matt Mackall and others
12:40:56     INFO -  This is free software; see the source for copying conditions. There is NO
12:40:56     INFO -  warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
12:40:56     INFO - Return code: 0
12:40:56     INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall']
12:40:56     INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall
12:40:56     INFO -  checking encoding (cp1252)...
12:40:56     INFO -  checking Python executable (c:\mozilla-build\hg\hg.exe)
12:40:56     INFO -  checking Python version (2.7.12)
12:40:56     INFO -  checking Python lib (c:\mozilla-build\hg\lib\library.zip)...
12:40:56     INFO -  checking Mercurial version (3.9.1)
12:40:56     INFO -  checking Mercurial custom build ()
12:40:56     INFO -  checking module policy (c)
12:40:56     INFO -  checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)...
12:40:56     INFO -  checking templates (c:\mozilla-build\hg\templates)...
12:40:56     INFO -  checking default template (c:\mozilla-build\hg\templates\map-cmdline.default)
12:40:56     INFO -  checking commit editor... (notepad)
12:40:56     INFO -  checking username (Mozilla Release Engineering <release@mozilla.com>)
12:40:56     INFO -  no problems detected
12:40:56     INFO - Return code: 0
12:40:56     INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/integration/autoland', 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\src', '--sharebase', 'C:/builds/hg-shared', '--upstream', 'https://hg.mozilla.org/mozilla-unified', '--revision', '508966268fab932a33c9c77be039b6a1b8d3d4ec']
12:40:56     INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\autoland-w32-d-000000000000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/integration/autoland c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\src --sharebase C:/builds/hg-shared --upstream https://hg.mozilla.org/mozilla-unified --revision 508966268fab932a33c9c77be039b6a1b8d3d4ec
12:53:28     INFO -  
12:53:28     INFO - clone [                                                ]    5475307/1916169005
12:53:28     INFO - clone [                                         ]    5648305/1916169005 19m06s
12:53:28     INFO - clone [                                         ]    5837297/1916169005 24m12s
12:53:28     INFO - clone [                                         ]    7138912/1916169005 24m15s
12:53:28     INFO - clone [                                         ]    7993525/1916169005 27m25s
12:53:28     INFO - clone [                                         ]    9103695/1916169005 27m33s
12:53:28     INFO - clone [                                         ]    9676267/1916169005 29m12s
12:53:28     INFO - clone [                                         ]   11693040/1916169005 26m53s
12:53:28     INFO - clone [                                         ]   12203097/1916169005 28m27s
12:53:28     INFO - clone [                                         ]   12734310/1916169005 29m45s
12:53:28     INFO - clone [                                         ]   12947377/1916169005 31m46s
12:53:28     INFO - clone [                                         ]   13030650/1916169005 34m04s
12:53:28     INFO - clone [                                         ]   13045964/1916169005 36m46s
12:53:28     INFO - clone [                                         ]   13162166/1916169005 39m04s
12:53:28     INFO - clone [                                         ]   13259100/1916169005 41m15s
12:53:28     INFO - clone [                                         ]   19797038/1916169005 29m13s
12:53:28     INFO - clone [                                         ]   19914570/1916169005 30m39s
12:53:28     INFO - clone [                                         ]   45322417/1916169005 14m45s
12:53:28     INFO - clone [                                         ]   45359227/1916169005 15m38s
12:53:28     INFO - clone [>                                        ]   46914017/1916169005 15m49s
12:53:28     INFO - clone [>                                        ]   49109304/1916169005 15m47s
12:53:28     INFO - clone [>                                        ]   49143861/1916169005 16m33s
12:53:28     INFO - clone [>                                        ]   52785312/1916169005 15m59s
12:53:28     INFO - clone [>                                        ]   61970600/1916169005 14m07s
12:53:28     INFO - clone [>                                        ]   61982140/1916169005 14m47s
12:53:28     INFO - clone [>                                        ]   62020704/1916169005 15m19s
12:53:28     INFO - clone [>                                        ]   63463354/1916169005 15m26s
12:53:28     INFO - clone [>                                        ]   65189281/1916169005 15m34s
12:53:28     INFO - clone [>                                        ]   65417089/1916169005 15m59s
12:53:28     INFO - clone [>                                        ]   66229613/1916169005 16m17s
12:53:28     INFO - clone [>                                        ]   76001103/1916169005 14m31s
12:53:28     INFO - clone [>                                        ]   80407356/1916169005 14m07s
12:53:28     INFO - clone [=>                                       ]   96588664/1916169005 11m58s
12:53:28     INFO - clone [=>                                       ]  103184564/1916169005 11m38s
12:53:28     INFO - clone [=>                                       ]  103222695/1916169005 11m59s
12:53:28     INFO - clone [=>                                       ]  104874163/1916169005 12m04s
12:53:28     INFO - clone [=>                                       ]  106056278/1916169005 12m13s
12:53:28     INFO - clone [=>                                       ]  113355998/1916169005 11m40s
12:53:28     INFO - clone [=>                                       ]  114338668/1916169005 11m49s
12:53:28     INFO - clone [=>                                       ]  117388882/1916169005 11m47s
12:53:28     INFO - clone [=>                                       ]  117821799/1916169005 12m00s
12:53:28     INFO - clone [=>                                       ]  123227559/1916169005 11m41s
12:53:28     INFO - clone [=>                                       ]  123966576/1916169005 11m54s
12:53:28     INFO - clone [=>                                       ]  124489126/1916169005 12m07s
12:53:28     INFO - clone [=>                                       ]  124971150/1916169005 12m19s
12:53:28     INFO - clone [=>                                       ]  125890256/1916169005 12m32s
12:53:28     INFO - clone [=>                                       ]  128088777/1916169005 12m33s
12:53:28     INFO - clone [=>                                       ]  128370413/1916169005 12m47s
12:53:28     INFO - clone [=>                                       ]  128420221/1916169005 13m01s
12:53:28     INFO - clone [=>                                       ]  132811072/1916169005 12m47s
12:53:28     INFO - clone [=>                                       ]  133888790/1916169005 12m54s
12:53:28     INFO - clone [=>                                       ]  134138528/1916169005 13m07s
12:53:28     INFO - clone [=>                                       ]  135517057/1916169005 13m12s
12:53:28     INFO - clone [=>                                       ]  136086477/1916169005 13m23s
12:53:28     INFO - clone [=>                                       ]  137354942/1916169005 13m29s
12:53:28     INFO - clone [=>                                       ]  137416794/1916169005 13m42s
12:53:28     INFO - clone [=>                                       ]  138571716/1916169005 13m50s
12:53:28     INFO - clone [=>                                       ]  139968089/1916169005 13m54s
12:53:28     INFO - clone [==>                                      ]  140644104/1916169005 14m04s
12:53:28     INFO - clone [==>                                      ]  140948949/1916169005 14m22s
12:53:28     INFO - clone [==>                                      ]  141833345/1916169005 14m29s
12:53:28     INFO - clone [==>                                      ]  142730900/1916169005 14m38s
12:53:28     INFO - clone [==>                                      ]  144346326/1916169005 14m40s
12:53:28     INFO - clone [==>                                      ]  144974557/1916169005 14m51s
12:53:28     INFO - clone [==>                                      ]  146823133/1916169005 14m51s
12:53:28     INFO - clone [==>                                      ]  147125251/1916169005 15m02s
12:53:28     INFO - clone [==>                                      ]  148143812/1916169005 15m07s
12:53:28     INFO - clone [==>                                      ]  148480290/1916169005 15m24s
12:53:28     INFO - clone [==>                                      ]  149738896/1916169005 15m28s
12:53:28     INFO - clone [==>                                      ]  150825954/1916169005 15m32s
12:53:28     INFO - clone [==>                                      ]  151633296/1916169005 15m41s
12:53:28     INFO - clone [==>                                      ]  157689964/1916169005 15m13s
12:53:28     INFO - clone [==>                                      ]  157933273/1916169005 15m26s
12:53:28     INFO - clone [==>                                      ]  159892614/1916169005 15m25s
12:53:28     INFO - clone [==>                                      ]  161969772/1916169005 15m25s
12:53:28     INFO - clone [==>                                      ]  170772730/1916169005 14m44s
12:53:28     INFO - clone [==>                                      ]  170779702/1916169005 14m54s
12:53:28     INFO - clone [==>                                      ]  178105829/1916169005 14m29s
12:53:28     INFO - clone [==>                                      ]  179601698/1916169005 14m31s
12:53:28     INFO - clone [==>                                      ]  180576553/1916169005 14m35s
12:53:28     INFO - clone [==>                                      ]  183867532/1916169005 14m27s
12:53:28     INFO - clone [==>                                      ]  184835902/1916169005 14m35s
12:53:28     INFO - clone [===>                                     ]  188980855/1916169005 14m27s
12:53:28     INFO - clone [===>                                     ]  196780448/1916169005 13m59s
12:53:28     INFO - clone [===>                                     ]  197102845/1916169005 14m10s
12:53:28     INFO - clone [===>                                     ]  200512031/1916169005 14m06s
12:53:28     INFO - clone [===>                                     ]  204773105/1916169005 13m55s
12:53:28     INFO - clone [===>                                     ]  205670478/1916169005 13m59s
12:53:28     INFO - clone [===>                                     ]  206250433/1916169005 14m05s
12:53:28     INFO - clone [===>                                     ]  210425724/1916169005 13m55s
12:53:28     INFO - clone [===>                                     ]  216580071/1916169005 13m36s
12:53:28     INFO - clone [===>                                     ]  219585786/1916169005 13m33s
12:53:28     INFO - clone [===>                                     ]  221405956/1916169005 13m33s
12:53:28     INFO - clone [===>                                     ]  228223521/1916169005 13m13s
12:53:28     INFO - clone [===>                                     ]  229096553/1916169005 13m17s
12:53:28     INFO - clone [===>                                     ]  230959201/1916169005 13m17s
12:53:28     INFO - clone [====>                                    ]  248041777/1916169005 12m21s
12:53:28     INFO - clone [====>                                    ]  250369469/1916169005 12m22s
12:53:28     INFO - clone [====>                                    ]  251258963/1916169005 12m26s
12:53:28     INFO - clone [====>                                    ]  252768308/1916169005 12m28s
12:53:28     INFO - clone [====>                                    ]  254607147/1916169005 12m28s
12:53:28     INFO - clone [====>                                    ]  256296961/1916169005 12m29s
12:53:28     INFO - clone [====>                                    ]  257554849/1916169005 12m32s
12:53:28     INFO - clone [====>                                    ]  258041219/1916169005 12m37s
12:53:28     INFO - clone [====>                                    ]  259517432/1916169005 12m38s
12:53:28     INFO - clone [====>                                    ]  262134513/1916169005 12m36s
12:53:28     INFO - clone [====>                                    ]  264792901/1916169005 12m37s
12:53:28     INFO - clone [====>                                    ]  265919062/1916169005 12m39s
12:53:28     INFO - clone [====>                                    ]  268383806/1916169005 12m38s
12:53:28     INFO - clone [====>                                    ]  271187750/1916169005 12m35s
12:53:28     INFO - clone [=====>                                   ]  280942713/1916169005 12m11s
12:53:28     INFO - clone [=====>                                   ]  292378373/1916169005 11m45s
12:53:28     INFO - clone [=====>                                   ]  293174450/1916169005 11m48s
12:53:28     INFO - clone [=====>                                   ]  295755084/1916169005 11m47s
12:53:28     INFO - clone [=====>                                   ]  296900045/1916169005 11m49s
12:53:28     INFO - clone [=====>                                   ]  300041056/1916169005 11m46s
12:53:28     INFO - clone [=====>                                   ]  302019542/1916169005 11m48s
12:53:28     INFO - clone [=====>                                   ]  304280134/1916169005 11m47s
12:53:28     INFO - clone [=====>                                   ]  305046319/1916169005 11m52s
12:53:28     INFO - clone [======>                                  ]  330281661/1916169005 10m52s
12:53:28     INFO - clone [======>                                  ]  331763952/1916169005 10m55s
12:53:28     INFO - clone [======>                                  ]  331800962/1916169005 11m01s
12:53:28     INFO - clone [======>                                  ]  331814625/1916169005 11m10s
12:53:28     INFO - clone [======>                                  ]  333949355/1916169005 11m10s
12:53:28     INFO - clone [======>                                  ]  335401772/1916169005 11m12s
12:53:28     INFO - clone [======>                                  ]  337222065/1916169005 11m13s
12:53:28     INFO - clone [======>                                  ]  338775086/1916169005 11m14s
12:53:28     INFO - clone [======>                                  ]  341036961/1916169005 11m13s
12:53:28     INFO - clone [======>                                  ]  344329706/1916169005 11m10s
12:53:28     INFO - clone [======>                                  ]  345898619/1916169005 11m11s
12:53:28     INFO - clone [======>                                  ]  347573356/1916169005 11m12s
12:53:28     INFO - clone [======>                                  ]  351388986/1916169005 11m09s
12:53:28     INFO - clone [======>                                  ]  353111082/1916169005 11m10s
12:53:28     INFO - clone [======>                                  ]  354711335/1916169005 11m15s
12:53:28     INFO - clone [======>                                  ]  355867134/1916169005 11m17s
12:53:28     INFO - clone [======>                                  ]  357367646/1916169005 11m18s
12:53:28     INFO - clone [======>                                  ]  362580488/1916169005 11m10s
12:53:28     INFO - clone [======>                                  ]  369785909/1916169005 10m58s
12:53:28     INFO - clone [======>                                  ]  371662175/1916169005 10m59s
12:53:28     INFO - clone [======>                                  ]  371692873/1916169005 11m03s
12:53:28     INFO - clone [=======>                                 ]  374572132/1916169005 11m02s
12:53:28     INFO - clone [=======>                                 ]  378823521/1916169005 11m01s
12:53:28     INFO - clone [=======>                                 ]  380062151/1916169005 11m02s
12:53:28     INFO - clone [=======>                                 ]  383387467/1916169005 10m59s
12:53:28     INFO - clone [=======>                                 ]  384994390/1916169005 11m00s
12:53:28     INFO - clone [=======>                                 ]  387885812/1916169005 10m59s
12:53:28     INFO - clone [=======>                                 ]  390194885/1916169005 10m58s
12:53:28     INFO - clone [=======>                                 ]  391174630/1916169005 11m01s
12:53:28     INFO - clone [=======>                                 ]  393567896/1916169005 11m01s
12:53:28     INFO - clone [=======>                                 ]  395763344/1916169005 11m00s
12:53:28     INFO - clone [=======>                                 ]  402372711/1916169005 10m52s
12:53:28     INFO - clone [=======>                                 ]  403578223/1916169005 10m53s
12:53:28     INFO - clone [=======>                                 ]  404359603/1916169005 10m56s
12:53:28     INFO - clone [=======>                                 ]  406083447/1916169005 10m56s
12:53:28     INFO - clone [=======>                                 ]  406467664/1916169005 10m59s
12:53:28     INFO - clone [=======>                                 ]  407203917/1916169005 11m02s
12:53:28     INFO - clone [=======>                                 ]  407744235/1916169005 11m06s
12:53:28     INFO - clone [=======>                                 ]  409608865/1916169005 11m06s
12:53:28     INFO - clone [=======>                                 ]  413297660/1916169005 11m02s
12:53:28     INFO - clone [=======>                                 ]  414756214/1916169005 11m03s
12:53:28     INFO - clone [=======>                                 ]  417689801/1916169005 11m01s
12:53:28     INFO - clone [=======>                                 ]  418207404/1916169005 11m03s
12:53:28     INFO - clone [=======>                                 ]  419752030/1916169005 11m04s
12:53:28     INFO - clone [=======>                                 ]  420019862/1916169005 11m07s
12:53:28     INFO - clone [========>                                ]  423864063/1916169005 11m03s
12:53:28     INFO - clone [========>                                ]  424906491/1916169005 11m05s
12:53:28     INFO - clone [========>                                ]  426446733/1916169005 11m05s
12:53:28     INFO - clone [========>                                ]  430778754/1916169005 11m00s
12:53:28     INFO - clone [========>                                ]  437748171/1916169005 10m50s
12:53:28     INFO - clone [========>                                ]  437793253/1916169005 10m54s
12:53:28     INFO - clone [========>                                ]  442073233/1916169005 10m49s
12:53:28     INFO - clone [========>                                ]  446463953/1916169005 10m44s
12:53:28     INFO - clone [========>                                ]  452794861/1916169005 10m36s
12:53:28     INFO - clone [========>                                ]  454847745/1916169005 10m35s
12:53:28     INFO - clone [========>                                ]  467041324/1916169005 10m19s
12:53:28     INFO - clone [=========>                               ]  470665213/1916169005 10m16s
12:53:28     INFO - clone [=========>                                ]  496786702/1916169005 9m36s
12:53:28     INFO - clone [=========>                                ]  499969272/1916169005 9m35s
12:53:28     INFO - clone [==========>                               ]  503672399/1916169005 9m32s
12:53:28     INFO - clone [==========>                               ]  504276450/1916169005 9m34s
12:53:28     INFO - clone [==========>                               ]  506528489/1916169005 9m34s
12:53:28     INFO - clone [==========>                               ]  507001796/1916169005 9m37s
12:53:28     INFO - clone [==========>                               ]  509466541/1916169005 9m40s
12:53:28     INFO - clone [==========>                               ]  511228881/1916169005 9m40s
12:53:28     INFO - clone [==========>                               ]  514767338/1916169005 9m38s
12:53:28     INFO - clone [==========>                               ]  516839649/1916169005 9m37s
12:53:28     INFO - clone [==========>                               ]  518827258/1916169005 9m37s
12:53:28     INFO - clone [==========>                               ]  519663473/1916169005 9m39s
12:53:28     INFO - clone [==========>                               ]  520115239/1916169005 9m41s
12:53:28     INFO - clone [==========>                               ]  521624833/1916169005 9m41s
12:53:28     INFO - clone [==========>                               ]  523614091/1916169005 9m41s
12:53:28     INFO - clone [==========>                               ]  524583475/1916169005 9m42s
12:53:28     INFO - clone [==========>                               ]  526719518/1916169005 9m43s
12:53:28     INFO - clone [==========>                               ]  529125175/1916169005 9m42s
12:53:28     INFO - clone [==========>                               ]  530741029/1916169005 9m43s
12:53:28     INFO - clone [==========>                               ]  530988258/1916169005 9m45s
12:53:28     INFO - clone [==========>                               ]  531828450/1916169005 9m46s
12:53:28     INFO - clone [==========>                               ]  532864418/1916169005 9m49s
12:53:28     INFO - clone [==========>                               ]  536638939/1916169005 9m46s
12:53:28     INFO - clone [==========>                               ]  537847506/1916169005 9m46s
12:53:28     INFO - clone [==========>                               ]  539841788/1916169005 9m46s
12:53:28     INFO - clone [==========>                               ]  540944090/1916169005 9m47s
12:53:28     INFO - clone [==========>                               ]  542995268/1916169005 9m47s
12:53:28     INFO - clone [==========>                               ]  544211677/1916169005 9m48s
12:53:28     INFO - clone [==========>                               ]  546013497/1916169005 9m47s
12:53:28     INFO - clone [==========>                               ]  546379607/1916169005 9m49s
12:53:28     INFO - clone [===========>                              ]  552595192/1916169005 9m43s
12:53:28     INFO - clone [===========>                              ]  554494905/1916169005 9m43s
12:53:28     INFO - clone [===========>                              ]  558398378/1916169005 9m40s
12:53:28     INFO - clone [===========>                              ]  560293543/1916169005 9m40s
12:53:28     INFO - clone [===========>                              ]  562302819/1916169005 9m39s
12:53:28     INFO - clone [===========>                              ]  566627840/1916169005 9m36s
12:53:28     INFO - clone [===========>                              ]  568970624/1916169005 9m39s
12:53:28     INFO - clone [===========>                              ]  577605309/1916169005 9m29s
12:53:28     INFO - clone [===========>                              ]  581515039/1916169005 9m27s
12:53:28     INFO - clone [===========>                              ]  582646112/1916169005 9m28s
12:53:28     INFO - clone [===========>                              ]  586770906/1916169005 9m25s
12:53:28     INFO - clone [===========>                              ]  588590407/1916169005 9m25s
12:53:28     INFO - clone [===========>                              ]  589807114/1916169005 9m26s
12:53:28     INFO - clone [===========>                              ]  592232359/1916169005 9m25s
12:53:28     INFO - clone [============>                             ]  595589104/1916169005 9m23s
12:53:28     INFO - clone [============>                             ]  598268881/1916169005 9m22s
12:53:28     INFO - clone [============>                             ]  601292752/1916169005 9m20s
12:53:28     INFO - clone [============>                             ]  602899001/1916169005 9m20s
12:53:28     INFO - clone [============>                             ]  605033690/1916169005 9m20s
12:53:28     INFO - clone [============>                             ]  606135934/1916169005 9m20s
12:53:28     INFO - clone [============>                             ]  608680230/1916169005 9m19s
12:53:28     INFO - clone [============>                             ]  609262468/1916169005 9m20s
12:53:28     INFO - clone [============>                             ]  609756384/1916169005 9m22s
12:53:28     INFO - clone [============>                             ]  612596758/1916169005 9m20s
12:53:28     INFO - clone [============>                             ]  614623471/1916169005 9m20s
12:53:28     INFO - clone [============>                             ]  619055582/1916169005 9m16s
12:53:28     INFO - clone [============>                             ]  622409148/1916169005 9m14s
12:53:28     INFO - clone [============>                             ]  624779115/1916169005 9m13s
12:53:28     INFO - clone [============>                             ]  628438333/1916169005 9m11s
12:53:28     INFO - clone [============>                             ]  629281037/1916169005 9m12s
12:53:28     INFO - clone [============>                             ]  632104983/1916169005 9m10s
12:53:28     INFO - clone [============>                             ]  637524510/1916169005 9m06s
12:53:28     INFO - clone [=============>                            ]  640449585/1916169005 9m04s
12:53:28     INFO - clone [=============>                            ]  643648177/1916169005 9m02s
12:53:28     INFO - clone [=============>                            ]  645318083/1916169005 9m02s
12:53:28     INFO - clone [=============>                            ]  652205622/1916169005 8m55s
12:53:28     INFO - clone [=============>                            ]  652706795/1916169005 8m57s
12:53:28     INFO - clone [=============>                            ]  656324630/1916169005 8m54s
12:53:28     INFO - clone [=============>                            ]  658270419/1916169005 8m54s
12:53:28     INFO - clone [=============>                            ]  662414976/1916169005 8m51s
12:53:28     INFO - clone [=============>                            ]  662810342/1916169005 8m52s
12:53:28     INFO - clone [=============>                            ]  665050954/1916169005 8m51s
12:53:28     INFO - clone [=============>                            ]  668206827/1916169005 8m49s
12:53:28     INFO - clone [=============>                            ]  670782114/1916169005 8m48s
12:53:28     INFO - clone [=============>                            ]  674102063/1916169005 8m46s
12:53:28     INFO - clone [=============>                            ]  677449287/1916169005 8m44s
12:53:28     INFO - clone [=============>                            ]  678736803/1916169005 8m44s
12:53:28     INFO - clone [=============>                            ]  680364483/1916169005 8m44s
12:53:28     INFO - clone [=============>                            ]  682381917/1916169005 8m44s
12:53:28     INFO - clone [==============>                           ]  685145361/1916169005 8m42s
12:53:28     INFO - clone [==============>                           ]  687017123/1916169005 8m42s
12:53:28     INFO - clone [==============>                           ]  691838200/1916169005 8m38s
12:53:28     INFO - clone [==============>                           ]  695937557/1916169005 8m35s
12:53:28     INFO - clone [==============>                           ]  698586966/1916169005 8m34s
12:53:28     INFO - clone [==============>                           ]  711448871/1916169005 8m21s
12:53:28     INFO - clone [==============>                           ]  711967844/1916169005 8m23s
12:53:28     INFO - clone [==============>                           ]  711970859/1916169005 8m25s
12:53:28     INFO - clone [==============>                           ]  712064580/1916169005 8m27s
12:53:28     INFO - clone [==============>                           ]  713023952/1916169005 8m28s
12:53:28     INFO - clone [==============>                           ]  713801021/1916169005 8m29s
12:53:28     INFO - clone [==============>                           ]  714110644/1916169005 8m30s
12:53:28     INFO - clone [==============>                           ]  714862664/1916169005 8m31s
12:53:28     INFO - clone [==============>                           ]  715911454/1916169005 8m31s
12:53:28     INFO - clone [==============>                           ]  719814321/1916169005 8m29s
12:53:28     INFO - clone [==============>                           ]  728684133/1916169005 8m21s
12:53:28     INFO - clone [===============>                          ]  730351724/1916169005 8m20s
12:53:28     INFO - clone [===============>                          ]  739246033/1916169005 8m12s
12:53:28     INFO - clone [===============>                          ]  754729749/1916169005 7m58s
12:53:28     INFO - clone [===============>                          ]  762487426/1916169005 7m52s
12:53:28     INFO - clone [===============>                          ]  762552962/1916169005 7m54s
12:53:28     INFO - clone [===============>                          ]  768841117/1916169005 7m49s
12:53:28     INFO - clone [===============>                          ]  771220039/1916169005 7m49s
12:53:28     INFO - clone [===============>                          ]  772533324/1916169005 7m49s
12:53:28     INFO - clone [================>                         ]  776254772/1916169005 7m47s
12:53:28     INFO - clone [================>                         ]  777091984/1916169005 7m48s
12:53:28     INFO - clone [================>                         ]  777858353/1916169005 7m49s
12:53:28     INFO - clone [================>                         ]  779573956/1916169005 7m49s
12:53:28     INFO - clone [================>                         ]  781247697/1916169005 7m48s
12:53:28     INFO - clone [================>                         ]  782089070/1916169005 7m49s
12:53:28     INFO - clone [================>                         ]  782619202/1916169005 7m50s
12:53:28     INFO - clone [================>                         ]  783064486/1916169005 7m51s
12:53:28     INFO - clone [================>                         ]  783449177/1916169005 7m52s
12:53:28     INFO - clone [================>                         ]  783780590/1916169005 7m53s
12:53:28     INFO - clone [================>                         ]  784284769/1916169005 7m54s
12:53:28     INFO - clone [================>                         ]  784697726/1916169005 7m55s
12:53:28     INFO - clone [================>                         ]  785007009/1916169005 7m57s
12:53:28     INFO - clone [================>                         ]  785492591/1916169005 7m58s
12:53:28     INFO - clone [================>                         ]  785783625/1916169005 7m59s
12:53:28     INFO - clone [================>                         ]  786358164/1916169005 8m00s
12:53:28     INFO - clone [================>                         ]  786875770/1916169005 8m01s
12:53:28     INFO - clone [================>                         ]  787249010/1916169005 8m02s
12:53:28     INFO - clone [================>                         ]  787695960/1916169005 8m03s
12:53:28     INFO - clone [================>                         ]  788310464/1916169005 8m03s
12:53:28     INFO - clone [================>                         ]  788555621/1916169005 8m05s
12:53:28     INFO - clone [================>                         ]  789034222/1916169005 8m06s
12:53:28     INFO - clone [================>                         ]  789418380/1916169005 8m07s
12:53:28     INFO - clone [================>                         ]  789957915/1916169005 8m08s
12:53:28     INFO - clone [================>                         ]  790322582/1916169005 8m09s
12:53:28     INFO - clone [================>                         ]  790895924/1916169005 8m10s
12:53:28     INFO - clone [================>                         ]  791344397/1916169005 8m11s
12:53:28     INFO - clone [================>                         ]  791819886/1916169005 8m12s
12:53:28     INFO - clone [================>                         ]  792236953/1916169005 8m13s
12:53:28     INFO - clone [================>                         ]  792807498/1916169005 8m14s
12:53:28     INFO - clone [================>                         ]  793628865/1916169005 8m14s
12:53:28     INFO - clone [================>                         ]  794315141/1916169005 8m15s
12:53:28     INFO - clone [================>                         ]  794608004/1916169005 8m16s
12:53:28     INFO - clone [================>                         ]  795428358/1916169005 8m17s
12:53:28     INFO - clone [================>                         ]  795893749/1916169005 8m18s
12:53:28     INFO - clone [================>                         ]  796320257/1916169005 8m19s
12:53:28     INFO - clone [================>                         ]  796968825/1916169005 8m20s
12:53:28     INFO - clone [================>                         ]  797634957/1916169005 8m21s
12:53:28     INFO - clone [================>                         ]  798151905/1916169005 8m21s
12:53:28     INFO - clone [================>                         ]  798661198/1916169005 8m22s
12:53:28     INFO - clone [================>                         ]  799432789/1916169005 8m23s
12:53:28     INFO - clone [================>                         ]  799733927/1916169005 8m24s
12:53:28     INFO - clone [================>                         ]  800213588/1916169005 8m25s
12:53:28     INFO - clone [================>                         ]  801248084/1916169005 8m25s
12:53:28     INFO - clone [================>                         ]  811160010/1916169005 8m16s
12:53:28     INFO - clone [================>                         ]  813249659/1916169005 8m16s
12:53:28     INFO - clone [================>                         ]  814322533/1916169005 8m16s
12:53:28     INFO - clone [================>                         ]  815863851/1916169005 8m16s
12:53:28     INFO - clone [================>                         ]  817116838/1916169005 8m16s
12:53:28     INFO - clone [================>                         ]  818444913/1916169005 8m16s
12:53:28     INFO - clone [================>                         ]  819508231/1916169005 8m16s
12:53:28     INFO - clone [================>                         ]  819800722/1916169005 8m17s
12:53:28     INFO - clone [=================>                        ]  821601294/1916169005 8m17s
12:53:28     INFO - clone [=================>                        ]  825297612/1916169005 8m14s
12:53:28     INFO - clone [=================>                        ]  828067419/1916169005 8m13s
12:53:28     INFO - clone [=================>                        ]  835095638/1916169005 8m07s
12:53:28     INFO - clone [=================>                        ]  835561495/1916169005 8m08s
12:53:28     INFO - clone [=================>                        ]  838477281/1916169005 8m06s
12:53:28     INFO - clone [=================>                        ]  846029467/1916169005 8m00s
12:53:28     INFO - clone [=================>                        ]  846831220/1916169005 8m00s
12:53:28     INFO - clone [=================>                        ]  847293070/1916169005 8m01s
12:53:28     INFO - clone [=================>                        ]  848219241/1916169005 8m02s
12:53:28     INFO - clone [=================>                        ]  852751527/1916169005 7m58s
12:53:28     INFO - clone [=================>                        ]  854399251/1916169005 7m58s
12:53:28     INFO - clone [=================>                        ]  854454214/1916169005 7m59s
12:53:28     INFO - clone [=================>                        ]  855177471/1916169005 8m00s
12:53:28     INFO - clone [=================>                        ]  855725282/1916169005 8m00s
12:53:28     INFO - clone [=================>                        ]  856197672/1916169005 8m01s
12:53:28     INFO - clone [=================>                        ]  856734484/1916169005 8m02s
12:53:28     INFO - clone [=================>                        ]  857441350/1916169005 8m03s
12:53:28     INFO - clone [=================>                        ]  858259995/1916169005 8m03s
12:53:28     INFO - clone [=================>                        ]  858504287/1916169005 8m04s
12:53:28     INFO - clone [=================>                        ]  859191408/1916169005 8m05s
12:53:28     INFO - clone [=================>                        ]  859633118/1916169005 8m06s
12:53:28     INFO - clone [=================>                        ]  860002356/1916169005 8m07s
12:53:28     INFO - clone [=================>                        ]  860738016/1916169005 8m07s
12:53:28     INFO - clone [==================>                       ]  870038524/1916169005 7m59s
12:53:28     INFO - clone [==================>                       ]  870806538/1916169005 7m59s
12:53:28     INFO - clone [==================>                       ]  871314697/1916169005 8m00s
12:53:28     INFO - clone [==================>                       ]  871729623/1916169005 8m01s
12:53:28     INFO - clone [==================>                       ]  872189746/1916169005 8m02s
12:53:28     INFO - clone [==================>                       ]  872882662/1916169005 8m03s
12:53:28     INFO - clone [==================>                       ]  873633142/1916169005 8m03s
12:53:28     INFO - clone [==================>                       ]  874390995/1916169005 8m04s
12:53:28     INFO - clone [==================>                       ]  874947029/1916169005 8m04s
12:53:28     INFO - clone [==================>                       ]  875510615/1916169005 8m05s
12:53:28     INFO - clone [==================>                       ]  876841226/1916169005 8m05s
12:53:28     INFO - clone [==================>                       ]  877619498/1916169005 8m05s
12:53:28     INFO - clone [==================>                       ]  878163737/1916169005 8m06s
12:53:28     INFO - clone [==================>                       ]  880337513/1916169005 8m05s
12:53:28     INFO - clone [==================>                       ]  880754522/1916169005 8m06s
12:53:28     INFO - clone [==================>                       ]  881642912/1916169005 8m07s
12:53:28     INFO - clone [==================>                       ]  882023888/1916169005 8m07s
12:53:28     INFO - clone [==================>                       ]  882981838/1916169005 8m08s
12:53:28     INFO - clone [==================>                       ]  883256234/1916169005 8m09s
12:53:28     INFO - clone [==================>                       ]  888335525/1916169005 8m05s
12:53:28     INFO - clone [==================>                       ]  893147716/1916169005 8m01s
12:53:28     INFO - clone [==================>                       ]  894619415/1916169005 8m01s
12:53:28     INFO - clone [==================>                       ]  897157752/1916169005 8m00s
12:53:28     INFO - clone [==================>                       ]  899947867/1916169005 7m58s
12:53:28     INFO - clone [==================>                       ]  902222786/1916169005 7m57s
12:53:28     INFO - clone [==================>                       ]  903618474/1916169005 7m57s
12:53:28     INFO - clone [==================>                       ]  906427623/1916169005 7m56s
12:53:28     INFO - clone [==================>                       ]  909252697/1916169005 7m54s
12:53:28     INFO - clone [===================>                      ]  912845573/1916169005 7m52s
12:53:28     INFO - clone [===================>                      ]  915263702/1916169005 7m51s
12:53:28     INFO - clone [===================>                      ]  916652605/1916169005 7m50s
12:53:28     INFO - clone [===================>                      ]  919952131/1916169005 7m48s
12:53:28     INFO - clone [===================>                      ]  921240438/1916169005 7m48s
12:53:28     INFO - clone [===================>                      ]  923402704/1916169005 7m47s
12:53:28     INFO - clone [===================>                      ]  926652527/1916169005 7m45s
12:53:28     INFO - clone [===================>                      ]  929816921/1916169005 7m43s
12:53:28     INFO - clone [===================>                      ]  930728439/1916169005 7m43s
12:53:28     INFO - clone [===================>                      ]  932618468/1916169005 7m43s
12:53:28     INFO - clone [===================>                      ]  933872169/1916169005 7m42s
12:53:28     INFO - clone [===================>                      ]  934149899/1916169005 7m44s
12:53:28     INFO - clone [===================>                      ]  936158853/1916169005 7m43s
12:53:28     INFO - clone [===================>                      ]  938059338/1916169005 7m42s
12:53:28     INFO - clone [===================>                      ]  938338858/1916169005 7m43s
12:53:28     INFO - clone [===================>                      ]  938852004/1916169005 7m43s
12:53:28     INFO - clone [===================>                      ]  940510252/1916169005 7m43s
12:53:28     INFO - clone [===================>                      ]  941729897/1916169005 7m43s
12:53:28     INFO - clone [===================>                      ]  943800167/1916169005 7m43s
12:53:28     INFO - clone [===================>                      ]  946390742/1916169005 7m42s
12:53:28     INFO - clone [===================>                      ]  947915195/1916169005 7m41s
12:53:28     INFO - clone [===================>                      ]  950440265/1916169005 7m40s
12:53:28     INFO - clone [===================>                      ]  951148705/1916169005 7m40s
12:53:28     INFO - clone [===================>                      ]  952808769/1916169005 7m40s
12:53:28     INFO - clone [===================>                      ]  954632139/1916169005 7m39s
12:53:28     INFO - clone [===================>                      ]  957049577/1916169005 7m38s
12:53:28     INFO - clone [====================>                     ]  959062367/1916169005 7m37s
12:53:28     INFO - clone [====================>                     ]  962337459/1916169005 7m35s
12:53:28     INFO - clone [====================>                     ]  964541822/1916169005 7m34s
12:53:28     INFO - clone [====================>                     ]  968353528/1916169005 7m31s
12:53:28     INFO - clone [====================>                     ]  969256304/1916169005 7m31s
12:53:28     INFO - clone [====================>                     ]  971295577/1916169005 7m30s
12:53:28     INFO - clone [====================>                     ]  974735178/1916169005 7m28s
12:53:28     INFO - clone [====================>                     ]  977443158/1916169005 7m27s
12:53:28     INFO - clone [====================>                     ]  983015844/1916169005 7m23s
12:53:28     INFO - clone [====================>                     ]  984620382/1916169005 7m23s
12:53:28     INFO - clone [====================>                     ]  985737025/1916169005 7m23s
12:53:28     INFO - clone [====================>                     ]  989155672/1916169005 7m21s
12:53:28     INFO - clone [====================>                     ]  990793954/1916169005 7m21s
12:53:28     INFO - clone [====================>                     ]  996117132/1916169005 7m17s
12:53:28     INFO - clone [====================>                     ] 1000709213/1916169005 7m14s
12:53:28     INFO - clone [=====================>                    ] 1010230762/1916169005 7m07s
12:53:28     INFO - clone [=====================>                    ] 1012511003/1916169005 7m05s
12:53:28     INFO - clone [=====================>                    ] 1013711218/1916169005 7m05s
12:53:28     INFO - clone [=====================>                    ] 1017527111/1916169005 7m03s
12:53:28     INFO - clone [=====================>                    ] 1019594896/1916169005 7m02s
12:53:28     INFO - clone [=====================>                    ] 1025862719/1916169005 6m57s
12:53:28     INFO - clone [=====================>                    ] 1027327160/1916169005 6m57s
12:53:28     INFO - clone [=====================>                    ] 1028287443/1916169005 6m57s
12:53:28     INFO - clone [=====================>                    ] 1032878616/1916169005 6m54s
12:53:28     INFO - clone [=====================>                    ] 1034114348/1916169005 6m54s
12:53:28     INFO - clone [=====================>                    ] 1038296393/1916169005 6m51s
12:53:28     INFO - clone [=====================>                    ] 1039656828/1916169005 6m51s
12:53:28     INFO - clone [=====================>                    ] 1040893233/1916169005 6m51s
12:53:28     INFO - clone [=====================>                    ] 1043949811/1916169005 6m49s
12:53:28     INFO - clone [=====================>                    ] 1046824895/1916169005 6m47s
12:53:28     INFO - clone [=====================>                    ] 1048866197/1916169005 6m46s
12:53:28     INFO - clone [======================>                   ] 1051195698/1916169005 6m45s
12:53:28     INFO - clone [======================>                   ] 1053280049/1916169005 6m44s
12:53:28     INFO - clone [======================>                   ] 1053941469/1916169005 6m45s
12:53:28     INFO - clone [======================>                   ] 1055495462/1916169005 6m44s
12:53:28     INFO - clone [======================>                   ] 1058471903/1916169005 6m42s
12:53:28     INFO - clone [======================>                   ] 1060415417/1916169005 6m42s
12:53:28     INFO - clone [======================>                   ] 1064910058/1916169005 6m39s
12:53:28     INFO - clone [======================>                   ] 1065799958/1916169005 6m39s
12:53:28     INFO - clone [======================>                   ] 1071580583/1916169005 6m35s
12:53:28     INFO - clone [======================>                   ] 1072943942/1916169005 6m34s
12:53:28     INFO - clone [======================>                   ] 1075638904/1916169005 6m33s
12:53:28     INFO - clone [======================>                   ] 1078062078/1916169005 6m32s
12:53:28     INFO - clone [======================>                   ] 1081504318/1916169005 6m30s
12:53:28     INFO - clone [======================>                   ] 1087077262/1916169005 6m26s
12:53:28     INFO - clone [=======================>                  ] 1097279532/1916169005 6m18s
12:53:28     INFO - clone [=======================>                  ] 1098549299/1916169005 6m18s
12:53:28     INFO - clone [=======================>                  ] 1101357810/1916169005 6m17s
12:53:28     INFO - clone [=======================>                  ] 1102174036/1916169005 6m17s
12:53:28     INFO - clone [=======================>                  ] 1103066726/1916169005 6m17s
12:53:28     INFO - clone [=======================>                  ] 1120379770/1916169005 6m04s
12:53:28     INFO - clone [=======================>                  ] 1121607047/1916169005 6m04s
12:53:28     INFO - clone [=======================>                  ] 1122058039/1916169005 6m05s
12:53:28     INFO - clone [========================>                 ] 1159817052/1916169005 5m37s
12:53:28     INFO - clone [========================>                 ] 1160581618/1916169005 5m37s
12:53:28     INFO - clone [========================>                 ] 1160840500/1916169005 5m37s
12:53:28     INFO - clone [========================>                 ] 1161201567/1916169005 5m38s
12:53:28     INFO - clone [========================>                 ] 1161208394/1916169005 5m39s
12:53:28     INFO - clone [========================>                 ] 1161211698/1916169005 5m39s
12:53:28     INFO - clone [========================>                 ] 1161347419/1916169005 5m40s
12:53:28     INFO - clone [========================>                 ] 1162335356/1916169005 5m40s
12:53:28     INFO - clone [========================>                 ] 1163706713/1916169005 5m40s
12:53:28     INFO - clone [========================>                 ] 1166191992/1916169005 5m39s
12:53:28     INFO - clone [========================>                 ] 1168178525/1916169005 5m38s
12:53:28     INFO - clone [========================>                 ] 1170410818/1916169005 5m37s
12:53:28     INFO - clone [========================>                 ] 1174241599/1916169005 5m35s
12:53:28     INFO - clone [========================>                 ] 1178381946/1916169005 5m32s
12:53:28     INFO - clone [========================>                 ] 1180058653/1916169005 5m32s
12:53:28     INFO - clone [=========================>                ] 1190907960/1916169005 5m24s
12:53:28     INFO - clone [=========================>                ] 1191592115/1916169005 5m25s
12:53:28     INFO - clone [=========================>                ] 1193579779/1916169005 5m24s
12:53:28     INFO - clone [=========================>                ] 1195611516/1916169005 5m23s
12:53:28     INFO - clone [=========================>                ] 1196867045/1916169005 5m23s
12:53:28     INFO - clone [=========================>                ] 1201462413/1916169005 5m20s
12:53:28     INFO - clone [=========================>                ] 1207831781/1916169005 5m16s
12:53:28     INFO - clone [=========================>                ] 1210644010/1916169005 5m15s
12:53:28     INFO - clone [=========================>                ] 1217844306/1916169005 5m10s
12:53:28     INFO - clone [=========================>                ] 1218346461/1916169005 5m11s
12:53:28     INFO - clone [=========================>                ] 1228036139/1916169005 5m04s
12:53:28     INFO - clone [=========================>                ] 1229206550/1916169005 5m04s
12:53:28     INFO - clone [=========================>                ] 1230286688/1916169005 5m04s
12:53:28     INFO - clone [==========================>               ] 1232563467/1916169005 5m03s
12:53:28     INFO - clone [==========================>               ] 1235305873/1916169005 5m02s
12:53:28     INFO - clone [==========================>               ] 1242107302/1916169005 4m58s
12:53:28     INFO - clone [==========================>               ] 1243340005/1916169005 4m57s
12:53:28     INFO - clone [==========================>               ] 1245168038/1916169005 4m57s
12:53:28     INFO - clone [==========================>               ] 1246687335/1916169005 4m56s
12:53:28     INFO - clone [==========================>               ] 1249047221/1916169005 4m55s
12:53:28     INFO - clone [==========================>               ] 1251861736/1916169005 4m55s
12:53:28     INFO - clone [==========================>               ] 1252281052/1916169005 4m55s
12:53:28     INFO - clone [==========================>               ] 1254555498/1916169005 4m54s
12:53:28     INFO - clone [==========================>               ] 1259079791/1916169005 4m52s
12:53:28     INFO - clone [==========================>               ] 1261077459/1916169005 4m51s
12:53:28     INFO - clone [==========================>               ] 1263441108/1916169005 4m50s
12:53:28     INFO - clone [==========================>               ] 1264776684/1916169005 4m49s
12:53:28     INFO - clone [==========================>               ] 1266138883/1916169005 4m49s
12:53:28     INFO - clone [==========================>               ] 1268074497/1916169005 4m48s
12:53:28     INFO - clone [==========================>               ] 1270063358/1916169005 4m48s
12:53:28     INFO - clone [===========================>              ] 1278519790/1916169005 4m42s
12:53:28     INFO - clone [===========================>              ] 1289601725/1916169005 4m36s
12:53:28     INFO - clone [===========================>              ] 1289621304/1916169005 4m36s
12:53:28     INFO - clone [===========================>              ] 1294340101/1916169005 4m34s
12:53:28     INFO - clone [===========================>              ] 1297744583/1916169005 4m32s
12:53:28     INFO - clone [===========================>              ] 1298189095/1916169005 4m32s
12:53:28     INFO - clone [===========================>              ] 1298715781/1916169005 4m32s
12:53:28     INFO - clone [===========================>              ] 1298949450/1916169005 4m33s
12:53:28     INFO - clone [===========================>              ] 1299229963/1916169005 4m33s
12:53:28     INFO - clone [===========================>              ] 1299538975/1916169005 4m33s
12:53:28     INFO - clone [===========================>              ] 1300235280/1916169005 4m33s
12:53:28     INFO - clone [===========================>              ] 1300601346/1916169005 4m34s
12:53:28     INFO - clone [===========================>              ] 1301102258/1916169005 4m34s
12:53:28     INFO - clone [===========================>              ] 1302032610/1916169005 4m34s
12:53:28     INFO - clone [===========================>              ] 1302792339/1916169005 4m34s
12:53:28     INFO - clone [===========================>              ] 1303344411/1916169005 4m34s
12:53:28     INFO - clone [===========================>              ] 1303390500/1916169005 4m34s
12:53:28     INFO - clone [===========================>              ] 1304491500/1916169005 4m34s
12:53:28     INFO - clone [===========================>              ] 1304780020/1916169005 4m34s
12:53:28     INFO - clone [===========================>              ] 1305631827/1916169005 4m34s
12:53:28     INFO - clone [===========================>              ] 1305981969/1916169005 4m35s
12:53:28     INFO - clone [===========================>              ] 1306180930/1916169005 4m35s
12:53:28     INFO - clone [===========================>              ] 1306619217/1916169005 4m35s
12:53:28     INFO - clone [===========================>              ] 1307069945/1916169005 4m35s
12:53:28     INFO - clone [===========================>              ] 1307556823/1916169005 4m35s
12:53:28     INFO - clone [===========================>              ] 1309510037/1916169005 4m35s
12:53:28     INFO - clone [===========================>              ] 1314467707/1916169005 4m32s
12:53:28     INFO - clone [===========================>              ] 1315206164/1916169005 4m32s
12:53:28     INFO - clone [===========================>              ] 1315862734/1916169005 4m32s
12:53:28     INFO - clone [===========================>              ] 1316018119/1916169005 4m32s
12:53:28     INFO - clone [===========================>              ] 1316587739/1916169005 4m32s
12:53:28     INFO - clone [===========================>              ] 1317745975/1916169005 4m32s
12:53:28     INFO - clone [===========================>              ] 1318463846/1916169005 4m32s
12:53:28     INFO - clone [============================>             ] 1330786737/1916169005 4m24s
12:53:28     INFO - clone [============================>             ] 1331114662/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1331625651/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1332448733/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1333258891/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1333763974/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1334380519/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1334741507/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1335328398/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1336059209/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1336666870/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1337792942/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1338143795/1916169005 4m25s
12:53:28     INFO - clone [============================>             ] 1343344576/1916169005 4m22s
12:53:28     INFO - clone [============================>             ] 1344496453/1916169005 4m22s
12:53:28     INFO - clone [============================>             ] 1345883412/1916169005 4m22s
12:53:28     INFO - clone [============================>             ] 1346619222/1916169005 4m22s
12:53:28     INFO - clone [============================>             ] 1346931488/1916169005 4m22s
12:53:28     INFO - clone [============================>             ] 1347795893/1916169005 4m22s
12:53:28     INFO - clone [============================>             ] 1348882020/1916169005 4m21s
12:53:28     INFO - clone [============================>             ] 1349461021/1916169005 4m21s
12:53:28     INFO - clone [============================>             ] 1350885519/1916169005 4m21s
12:53:28     INFO - clone [============================>             ] 1356346288/1916169005 4m18s
12:53:28     INFO - clone [============================>             ] 1359496534/1916169005 4m16s
12:53:28     INFO - clone [============================>             ] 1361621378/1916169005 4m15s
12:53:28     INFO - clone [============================>             ] 1363558381/1916169005 4m15s
12:53:28     INFO - clone [============================>             ] 1365483259/1916169005 4m14s
12:53:28     INFO - clone [============================>             ] 1366804853/1916169005 4m13s
12:53:28     INFO - clone [=============================>            ] 1369501202/1916169005 4m12s
12:53:28     INFO - clone [=============================>            ] 1372711657/1916169005 4m10s
12:53:28     INFO - clone [=============================>            ] 1375917987/1916169005 4m09s
12:53:28     INFO - clone [=============================>            ] 1377830487/1916169005 4m08s
12:53:28     INFO - clone [=============================>            ] 1380906093/1916169005 4m06s
12:53:28     INFO - clone [=============================>            ] 1381692247/1916169005 4m06s
12:53:28     INFO - clone [=============================>            ] 1384992929/1916169005 4m05s
12:53:28     INFO - clone [=============================>            ] 1386670308/1916169005 4m04s
12:53:28     INFO - clone [=============================>            ] 1390774162/1916169005 4m02s
12:53:28     INFO - clone [=============================>            ] 1394388037/1916169005 4m00s
12:53:28     INFO - clone [=============================>            ] 1398491802/1916169005 3m58s
12:53:28     INFO - clone [=============================>            ] 1401857672/1916169005 3m56s
12:53:28     INFO - clone [=============================>            ] 1403709672/1916169005 3m55s
12:53:28     INFO - clone [=============================>            ] 1406987664/1916169005 3m54s
12:53:28     INFO - clone [=============================>            ] 1411321609/1916169005 3m51s
12:53:28     INFO - clone [==============================>           ] 1415345426/1916169005 3m49s
12:53:28     INFO - clone [==============================>           ] 1418162623/1916169005 3m48s
12:53:28     INFO - clone [==============================>           ] 1421514280/1916169005 3m46s
12:53:28     INFO - clone [==============================>           ] 1424241933/1916169005 3m45s
12:53:28     INFO - clone [==============================>           ] 1428690568/1916169005 3m42s
12:53:28     INFO - clone [==============================>           ] 1431501482/1916169005 3m41s
12:53:28     INFO - clone [==============================>           ] 1432993619/1916169005 3m40s
12:53:28     INFO - clone [==============================>           ] 1434042376/1916169005 3m40s
12:53:28     INFO - clone [==============================>           ] 1437224558/1916169005 3m38s
12:53:28     INFO - clone [==============================>           ] 1440056150/1916169005 3m37s
12:53:28     INFO - clone [==============================>           ] 1441910021/1916169005 3m36s
12:53:28     INFO - clone [==============================>           ] 1443179484/1916169005 3m36s
12:53:28     INFO - clone [==============================>           ] 1444381500/1916169005 3m35s
12:53:28     INFO - clone [==============================>           ] 1445979788/1916169005 3m35s
12:53:28     INFO - clone [==============================>           ] 1449407268/1916169005 3m33s
12:53:28     INFO - clone [==============================>           ] 1450838868/1916169005 3m33s
12:53:28     INFO - clone [==============================>           ] 1453541786/1916169005 3m31s
12:53:28     INFO - clone [==============================>           ] 1457407699/1916169005 3m29s
12:53:28     INFO - clone [==============================>           ] 1459796789/1916169005 3m28s
12:53:28     INFO - clone [===============================>          ] 1466035305/1916169005 3m25s
12:53:28     INFO - clone [===============================>          ] 1467909188/1916169005 3m24s
12:53:28     INFO - clone [===============================>          ] 1470522989/1916169005 3m23s
12:53:28     INFO - clone [===============================>          ] 1473164496/1916169005 3m22s
12:53:28     INFO - clone [===============================>          ] 1479516898/1916169005 3m18s
12:53:28     INFO - clone [===============================>          ] 1480501449/1916169005 3m18s
12:53:28     INFO - clone [===============================>          ] 1483476635/1916169005 3m17s
12:53:28     INFO - clone [===============================>          ] 1485352136/1916169005 3m16s
12:53:28     INFO - clone [===============================>          ] 1485457830/1916169005 3m16s
12:53:28     INFO - clone [===============================>          ] 1486949232/1916169005 3m15s
12:53:28     INFO - clone [=================================>        ] 1575321519/1916169005 2m27s
12:53:28     INFO - clone [===================================>      ] 1648132015/1916169005 1m51s
12:53:28     INFO - clone [=======================================>    ] 1775927215/1916169005 54s
12:53:28     INFO - clone [=======================================>    ] 1782309308/1916169005 52s
12:53:28     INFO - clone [==========================================> ] 1903344508/1916169005 05s
12:53:28     INFO -                                                                                
12:53:28     INFO - 
12:53:28     INFO - changesets [                                                         ]   1/172
12:53:28     INFO -                                                                                
12:53:28     INFO - 
12:53:28     INFO - files [                                                            ]    1/3968
12:53:28     INFO - files [==========>                                                 ]  763/3968
12:53:28     INFO - files [=================>                                      ] 1281/3968 05s
12:53:28     INFO - files [==================>                                     ] 1351/3968 07s
12:53:28     INFO - files [==================>                                     ] 1357/3968 10s
12:53:28     INFO - files [==================>                                     ] 1359/3968 12s
12:53:28     INFO - files [==================>                                     ] 1399/3968 13s
12:53:28     INFO - files [====================>                                   ] 1521/3968 14s
12:53:28     INFO - files [====================>                                   ] 1526/3968 15s
12:53:28     INFO - files [====================>                                   ] 1533/3968 17s
12:53:28     INFO - files [======================>                                 ] 1640/3968 18s
12:53:28     INFO - files [======================>                                 ] 1642/3968 20s
12:53:28     INFO - files [======================>                                 ] 1650/3968 21s
12:53:28     INFO - files [=======================>                                ] 1756/3968 20s
12:53:28     INFO - files [===============================>                        ] 2324/3968 13s
12:53:28     INFO - files [=========================================>              ] 2981/3968 06s
12:53:28     INFO -                                                                                
12:53:28     INFO - ensuring https://hg.mozilla.org/integration/autoland@508966268fab932a33c9c77be039b6a1b8d3d4ec is available at c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\src
12:53:28     INFO -  (cloning from upstream repo https://hg.mozilla.org/mozilla-unified)
12:53:28     INFO -  (sharing from new pooled repository 8ba995b74e18334ab3707f27e9eb8f4e37ba3d29)
12:53:28     INFO -  applying clone bundle from https://s3-external-1.amazonaws.com/moz-hg-bundles-us-east-1/mozilla-unified/c56bd0d1e7c95a1f82a9b909282ccd2f1a3acc9a.packed1.hg
12:53:28     INFO -  325493 files to transfer, 1.78 GB of data
12:53:28     INFO -  transferred 1.78 GB in 683.2 seconds (2.67 MB/sec)
12:53:28     INFO -  finished applying clone bundle
12:53:28     INFO -  searching for changes
12:53:28     INFO -  adding changesets
12:53:28     INFO -  adding manifests
12:53:28     INFO -  adding file changes
12:53:28     INFO -  added 172 changesets with 4391 changes to 3097 files
12:54:03     INFO -  
12:54:03     INFO - searching [ <=>                                                            ] 2
12:54:03     INFO - searching [  <=>                                                           ] 4
12:54:03     INFO -                                                                                
12:54:03     INFO - searching for changes
12:54:03     INFO -  no changes found
12:54:03     INFO -  adding remote bookmark aurora
12:54:03     INFO -  adding remote bookmark beta
12:54:03     INFO -  adding remote bookmark central
12:54:03     INFO -  adding remote bookmark esr10
12:54:03     INFO -  adding remote bookmark esr17
12:54:03     INFO -  adding remote bookmark esr24
12:54:03     INFO -  adding remote bookmark esr31
12:54:03     INFO -  adding remote bookmark esr38
12:54:03     INFO -  adding remote bookmark esr45
12:54:03     INFO -  adding remote bookmark esr52
12:54:03     INFO -  adding remote bookmark fx-team
12:54:03     INFO -  adding remote bookmark inbound
12:54:03     INFO -  adding remote bookmark release
12:54:03     INFO -  (pulling to obtain 508966268fab932a33c9c77be039b6a1b8d3d4ec)
12:54:03     INFO -  searching for changes
12:54:03     INFO -  adding changesets
12:54:03     INFO -  adding manifests
12:54:03     INFO -  adding file changes
12:54:03     INFO -  added 88 changesets with 619 changes to 355 files (+1 heads)
13:02:32     INFO -  
13:02:32     INFO - updating [                                                     ]    100/187002
13:02:32     INFO - updating [                                                     ]    400/187002
13:02:32     INFO - updating [                                              ]    900/187002 10m00s
13:02:32     INFO - updating [                                               ]   1500/187002 8m14s
13:02:32     INFO - updating [                                               ]   2000/187002 7m50s
13:02:32     INFO - updating [                                               ]   2300/187002 8m15s
13:02:32     INFO - updating [                                               ]   2600/187002 8m29s
13:02:32     INFO - updating [                                               ]   2800/187002 9m08s
13:02:32     INFO - updating [                                              ]   3300/187002 11m29s
13:02:32     INFO - updating [                                              ]   3800/187002 10m45s
13:02:32     INFO - updating [>                                             ]   4200/187002 10m28s
13:02:32     INFO - updating [>                                             ]   4500/187002 10m46s
13:02:32     INFO - updating [>                                             ]   4900/187002 10m49s
13:02:32     INFO - updating [>                                             ]   5100/187002 10m58s
13:02:32     INFO - updating [>                                             ]   5600/187002 10m31s
13:02:32     INFO - updating [>                                             ]   5700/187002 10m57s
13:02:32     INFO - updating [>                                             ]   6000/187002 11m03s
13:02:32     INFO - updating [>                                             ]   6400/187002 11m14s
13:02:32     INFO - updating [>                                             ]   7200/187002 10m24s
13:02:32     INFO - updating [>                                             ]   7400/187002 10m33s
13:02:32     INFO - updating [>                                             ]   7800/187002 10m27s
13:02:32     INFO - updating [>                                             ]   7900/187002 10m52s
13:02:32     INFO - updating [=>                                            ]   8600/187002 10m42s
13:02:32     INFO - updating [=>                                            ]   9000/187002 10m35s
13:02:32     INFO - updating [=>                                            ]   9400/187002 10m26s
13:02:32     INFO - updating [=>                                            ]   9700/187002 10m25s
13:02:32     INFO - updating [=>                                            ]  10100/187002 10m17s
13:02:32     INFO - updating [=>                                            ]  10500/187002 10m13s
13:02:32     INFO - updating [=>                                            ]  10700/187002 10m19s
13:02:32     INFO - updating [=>                                            ]  11100/187002 10m17s
13:02:32     INFO - updating [=>                                            ]  11500/187002 10m11s
13:02:32     INFO - updating [==>                                            ]  12100/187002 9m54s
13:02:32     INFO - updating [==>                                            ]  12400/187002 9m53s
13:02:32     INFO - updating [==>                                            ]  12700/187002 9m55s
13:02:32     INFO - updating [==>                                           ]  12800/187002 10m08s
13:02:32     INFO - updating [==>                                            ]  13500/187002 9m55s
13:02:32     INFO - updating [==>                                            ]  13800/187002 9m54s
13:02:32     INFO - updating [==>                                            ]  14200/187002 9m50s
13:02:32     INFO - updating [==>                                            ]  14800/187002 9m42s
13:02:32     INFO - updating [==>                                            ]  15300/187002 9m36s
13:02:32     INFO - updating [==>                                            ]  15700/187002 9m31s
13:02:32     INFO - updating [===>                                           ]  16000/187002 9m32s
13:02:32     INFO - updating [===>                                           ]  16100/187002 9m40s
13:02:32     INFO - updating [===>                                           ]  16700/187002 9m32s
13:02:32     INFO - updating [===>                                           ]  17100/187002 9m38s
13:02:32     INFO - updating [===>                                           ]  17500/187002 9m33s
13:02:32     INFO - updating [===>                                           ]  18100/187002 9m22s
13:02:32     INFO - updating [===>                                           ]  18700/187002 9m12s
13:02:32     INFO - updating [===>                                           ]  19200/187002 9m08s
13:02:32     INFO - updating [===>                                           ]  19600/187002 9m05s
13:02:32     INFO - updating [====>                                          ]  19900/187002 9m05s
13:02:32     INFO - updating [====>                                          ]  20500/187002 8m55s
13:02:32     INFO - updating [====>                                          ]  20800/187002 8m57s
13:02:32     INFO - updating [====>                                          ]  20900/187002 9m04s
13:02:32     INFO - updating [====>                                          ]  21300/187002 9m01s
13:02:32     INFO - updating [====>                                          ]  21800/187002 8m59s
13:02:32     INFO - updating [====>                                          ]  22100/187002 9m00s
13:02:32     INFO - updating [====>                                          ]  22700/187002 8m52s
13:02:32     INFO - updating [====>                                          ]  23100/187002 8m49s
13:02:32     INFO - updating [=====>                                         ]  24000/187002 8m39s
13:02:32     INFO - updating [=====>                                         ]  24400/187002 8m38s
13:02:32     INFO - updating [=====>                                         ]  24800/187002 8m36s
13:02:32     INFO - updating [=====>                                         ]  25100/187002 8m36s
13:02:32     INFO - updating [=====>                                         ]  25700/187002 8m29s
13:02:32     INFO - updating [=====>                                         ]  26200/187002 8m24s
13:02:32     INFO - updating [=====>                                         ]  26900/187002 8m15s
13:02:32     INFO - updating [=====>                                         ]  27100/187002 8m24s
13:02:32     INFO - updating [=====>                                         ]  27700/187002 8m19s
13:02:32     INFO - updating [======>                                        ]  28000/187002 8m26s
13:02:32     INFO - updating [======>                                        ]  28400/187002 8m25s
13:02:32     INFO - updating [======>                                        ]  29000/187002 8m18s
13:02:32     INFO - updating [======>                                        ]  29200/187002 8m21s
13:02:32     INFO - updating [======>                                        ]  29400/187002 8m24s
13:02:32     INFO - updating [======>                                        ]  29700/187002 8m25s
13:02:32     INFO - updating [======>                                        ]  30000/187002 8m39s
13:02:32     INFO - updating [======>                                        ]  30600/187002 8m34s
13:02:32     INFO - updating [======>                                        ]  31300/187002 8m26s
13:02:32     INFO - updating [======>                                        ]  31800/187002 8m23s
13:02:32     INFO - updating [=======>                                       ]  32100/187002 8m23s
13:02:32     INFO - updating [=======>                                       ]  32600/187002 8m19s
13:02:32     INFO - updating [=======>                                       ]  33200/187002 8m13s
13:02:32     INFO - updating [=======>                                       ]  33700/187002 8m10s
13:02:32     INFO - updating [=======>                                       ]  34100/187002 8m13s
13:02:32     INFO - updating [=======>                                       ]  34400/187002 8m15s
13:02:32     INFO - updating [=======>                                       ]  35100/187002 8m07s
13:02:32     INFO - updating [=======>                                       ]  35700/187002 8m02s
13:02:32     INFO - updating [========>                                      ]  36700/187002 7m52s
13:02:32     INFO - updating [========>                                      ]  37200/187002 7m48s
13:02:32     INFO - updating [========>                                      ]  37500/187002 7m48s
13:02:32     INFO - updating [========>                                      ]  38000/187002 7m46s
13:02:32     INFO - updating [========>                                      ]  38900/187002 7m37s
13:02:32     INFO - updating [========>                                      ]  39200/187002 7m37s
13:02:32     INFO - updating [========>                                      ]  39700/187002 7m34s
13:02:32     INFO - updating [=========>                                     ]  39900/187002 7m35s
13:02:32     INFO - updating [=========>                                     ]  40200/187002 7m34s
13:02:32     INFO - updating [=========>                                     ]  40400/187002 7m36s
13:02:32     INFO - updating [=========>                                     ]  40800/187002 7m37s
13:02:32     INFO - updating [=========>                                     ]  41500/187002 7m34s
13:02:32     INFO - updating [=========>                                     ]  41800/187002 7m33s
13:02:32     INFO - updating [=========>                                     ]  42100/187002 7m33s
13:02:32     INFO - updating [=========>                                     ]  42700/187002 7m28s
13:02:32     INFO - updating [=========>                                     ]  42900/187002 7m30s
13:02:32     INFO - updating [=========>                                     ]  43100/187002 7m31s
13:02:32     INFO - updating [=========>                                     ]  43500/187002 7m32s
13:02:32     INFO - updating [==========>                                    ]  44200/187002 7m26s
13:02:32     INFO - updating [==========>                                    ]  44400/187002 7m30s
13:02:32     INFO - updating [==========>                                    ]  44900/187002 7m30s
13:02:32     INFO - updating [==========>                                    ]  45700/187002 7m23s
13:02:32     INFO - updating [==========>                                    ]  46400/187002 7m18s
13:02:32     INFO - updating [==========>                                    ]  46500/187002 7m22s
13:02:32     INFO - updating [==========>                                    ]  46900/187002 7m20s
13:02:32     INFO - updating [==========>                                    ]  47600/187002 7m15s
13:02:32     INFO - updating [==========>                                    ]  47700/187002 7m17s
13:02:32     INFO - updating [===========>                                   ]  48400/187002 7m18s
13:02:32     INFO - updating [===========>                                   ]  48900/187002 7m15s
13:02:32     INFO - updating [===========>                                   ]  49300/187002 7m17s
13:02:32     INFO - updating [===========>                                   ]  49700/187002 7m16s
13:02:32     INFO - updating [===========>                                   ]  50200/187002 7m14s
13:02:32     INFO - updating [===========>                                   ]  50600/187002 7m13s
13:02:32     INFO - updating [===========>                                   ]  50900/187002 7m13s
13:02:32     INFO - updating [===========>                                   ]  51200/187002 7m14s
13:02:32     INFO - updating [===========>                                   ]  51600/187002 7m14s
13:02:32     INFO - updating [============>                                  ]  52100/187002 7m11s
13:02:32     INFO - updating [============>                                  ]  52200/187002 7m13s
13:02:32     INFO - updating [============>                                  ]  53200/187002 7m05s
13:02:32     INFO - updating [============>                                  ]  54200/187002 6m57s
13:02:32     INFO - updating [============>                                  ]  55000/187002 6m51s
13:02:32     INFO - updating [=============>                                 ]  56000/187002 6m43s
13:02:32     INFO - updating [=============>                                 ]  56700/187002 6m39s
13:02:32     INFO - updating [=============>                                 ]  57200/187002 6m36s
13:02:32     INFO - updating [=============>                                 ]  57400/187002 6m37s
13:02:32     INFO - updating [=============>                                 ]  57600/187002 6m38s
13:02:32     INFO - updating [=============>                                 ]  58000/187002 6m37s
13:02:32     INFO - updating [=============>                                 ]  58200/187002 6m40s
13:02:32     INFO - updating [=============>                                 ]  58600/187002 6m38s
13:02:32     INFO - updating [=============>                                 ]  59000/187002 6m37s
13:02:32     INFO - updating [==============>                                ]  59800/187002 6m32s
13:02:32     INFO - updating [==============>                                ]  60200/187002 6m30s
13:02:32     INFO - updating [==============>                                ]  60600/187002 6m29s
13:02:32     INFO - updating [==============>                                ]  60900/187002 6m29s
13:02:32     INFO - updating [==============>                                ]  61400/187002 6m28s
13:02:32     INFO - updating [==============>                                ]  62100/187002 6m23s
13:02:32     INFO - updating [==============>                                ]  62600/187002 6m21s
13:02:32     INFO - updating [==============>                                ]  63100/187002 6m19s
13:02:32     INFO - updating [===============>                               ]  64100/187002 6m13s
13:02:32     INFO - updating [===============>                               ]  64700/187002 6m09s
13:02:32     INFO - updating [===============>                               ]  65200/187002 6m08s
13:02:32     INFO - updating [===============>                               ]  66100/187002 6m02s
13:02:32     INFO - updating [===============>                               ]  66600/187002 6m00s
13:02:32     INFO - updating [===============>                               ]  67500/187002 5m55s
13:02:32     INFO - updating [================>                              ]  68000/187002 5m53s
13:02:32     INFO - updating [================>                              ]  68700/187002 5m49s
13:02:32     INFO - updating [================>                              ]  69300/187002 5m46s
13:02:32     INFO - updating [================>                              ]  70000/187002 5m42s
13:02:32     INFO - updating [================>                              ]  70700/187002 5m39s
13:02:32     INFO - updating [================>                              ]  71200/187002 5m37s
13:02:32     INFO - updating [=================>                             ]  71800/187002 5m34s
13:02:32     INFO - updating [=================>                             ]  72100/187002 5m34s
13:02:32     INFO - updating [=================>                             ]  73000/187002 5m29s
13:02:32     INFO - updating [=================>                             ]  73600/187002 5m26s
13:02:32     INFO - updating [=================>                             ]  74300/187002 5m23s
13:02:32     INFO - updating [=================>                             ]  74800/187002 5m21s
13:02:32     INFO - updating [=================>                             ]  75200/187002 5m19s
13:02:32     INFO - updating [==================>                            ]  75700/187002 5m17s
13:02:32     INFO - updating [==================>                            ]  76200/187002 5m16s
13:02:32     INFO - updating [==================>                            ]  76900/187002 5m13s
13:02:32     INFO - updating [==================>                            ]  77400/187002 5m11s
13:02:32     INFO - updating [==================>                            ]  78300/187002 5m06s
13:02:32     INFO - updating [==================>                            ]  79100/187002 5m02s
13:02:32     INFO - updating [===================>                           ]  79900/187002 4m59s
13:02:32     INFO - updating [===================>                           ]  80300/187002 4m57s
13:02:32     INFO - updating [===================>                           ]  80900/187002 4m55s
13:02:32     INFO - updating [===================>                           ]  81600/187002 4m52s
13:02:32     INFO - updating [===================>                           ]  82100/187002 4m51s
13:02:32     INFO - updating [===================>                           ]  82700/187002 4m48s
13:02:32     INFO - updating [===================>                           ]  83200/187002 4m47s
13:02:32     INFO - updating [====================>                          ]  84200/187002 4m42s
13:02:32     INFO - updating [====================>                          ]  84800/187002 4m39s
13:02:32     INFO - updating [====================>                          ]  85700/187002 4m36s
13:02:32     INFO - updating [====================>                          ]  86300/187002 4m33s
13:02:32     INFO - updating [====================>                          ]  86800/187002 4m32s
13:02:32     INFO - updating [====================>                          ]  87200/187002 4m31s
13:02:32     INFO - updating [=====================>                         ]  87600/187002 4m30s
13:02:32     INFO - updating [=====================>                         ]  88100/187002 4m28s
13:02:32     INFO - updating [=====================>                         ]  88700/187002 4m26s
13:02:32     INFO - updating [=====================>                         ]  89200/187002 4m25s
13:02:32     INFO - updating [=====================>                         ]  89900/187002 4m22s
13:02:32     INFO - updating [=====================>                         ]  90400/187002 4m21s
13:02:32     INFO - updating [=====================>                         ]  91200/187002 4m18s
13:02:32     INFO - updating [======================>                        ]  91600/187002 4m17s
13:02:32     INFO - updating [======================>                        ]  91800/187002 4m17s
13:02:32     INFO - updating [======================>                        ]  92300/187002 4m16s
13:02:32     INFO - updating [======================>                        ]  92900/187002 4m14s
13:02:32     INFO - updating [======================>                        ]  93500/187002 4m12s
13:02:32     INFO - updating [======================>                        ]  94000/187002 4m10s
13:02:32     INFO - updating [======================>                        ]  95000/187002 4m06s
13:02:32     INFO - updating [=======================>                       ]  96000/187002 4m02s
13:02:32     INFO - updating [=======================>                       ]  96300/187002 4m01s
13:02:32     INFO - updating [=======================>                       ]  97300/187002 3m57s
13:02:32     INFO - updating [=======================>                       ]  98100/187002 3m54s
13:02:32     INFO - updating [=======================>                       ]  98500/187002 3m53s
13:02:32     INFO - updating [=======================>                       ]  99300/187002 3m50s
13:02:32     INFO - updating [========================>                      ] 100100/187002 3m47s
13:02:32     INFO - updating [========================>                      ] 100900/187002 3m46s
13:02:32     INFO - updating [========================>                      ] 101200/187002 3m46s
13:02:32     INFO - updating [========================>                      ] 102200/187002 3m42s
13:02:32     INFO - updating [========================>                      ] 103100/187002 3m39s
13:02:32     INFO - updating [=========================>                     ] 103800/187002 3m36s
13:02:32     INFO - updating [=========================>                     ] 104600/187002 3m34s
13:02:32     INFO - updating [=========================>                     ] 105600/187002 3m30s
13:02:32     INFO - updating [=========================>                     ] 106300/187002 3m28s
13:02:32     INFO - updating [=========================>                     ] 106800/187002 3m27s
13:02:32     INFO - updating [=========================>                     ] 107400/187002 3m25s
13:02:32     INFO - updating [==========================>                    ] 108200/187002 3m22s
13:02:32     INFO - updating [==========================>                    ] 109100/187002 3m19s
13:02:32     INFO - updating [==========================>                    ] 109800/187002 3m17s
13:02:32     INFO - updating [==========================>                    ] 110700/187002 3m13s
13:02:32     INFO - updating [==========================>                    ] 111100/187002 3m13s
13:02:32     INFO - updating [===========================>                   ] 111600/187002 3m11s
13:02:32     INFO - updating [===========================>                   ] 112100/187002 3m10s
13:02:32     INFO - updating [===========================>                   ] 112600/187002 3m09s
13:02:32     INFO - updating [===========================>                   ] 113600/187002 3m05s
13:02:32     INFO - updating [===========================>                   ] 114100/187002 3m04s
13:02:32     INFO - updating [===========================>                   ] 114800/187002 3m02s
13:02:32     INFO - updating [===========================>                   ] 115100/187002 3m01s
13:02:32     INFO - updating [============================>                  ] 115500/187002 3m00s
13:02:32     INFO - updating [============================>                  ] 116100/187002 2m59s
13:02:32     INFO - updating [============================>                  ] 116500/187002 2m58s
13:02:32     INFO - updating [============================>                  ] 116800/187002 2m57s
13:02:32     INFO - updating [============================>                  ] 117000/187002 2m57s
13:02:32     INFO - updating [============================>                  ] 117600/187002 2m56s
13:02:32     INFO - updating [============================>                  ] 117700/187002 2m56s
13:02:32     INFO - updating [============================>                  ] 118400/187002 2m54s
13:02:32     INFO - updating [============================>                  ] 118600/187002 2m55s
13:02:32     INFO - updating [============================>                  ] 118900/187002 2m54s
13:02:32     INFO - updating [=============================>                 ] 119600/187002 2m52s
13:02:32     INFO - updating [=============================>                 ] 120400/187002 2m50s
13:02:32     INFO - updating [=============================>                 ] 121100/187002 2m48s
13:02:32     INFO - updating [=============================>                 ] 121400/187002 2m47s
13:02:32     INFO - updating [=============================>                 ] 121600/187002 2m47s
13:02:32     INFO - updating [=============================>                 ] 122000/187002 2m46s
13:02:32     INFO - updating [=============================>                 ] 122700/187002 2m44s
13:02:32     INFO - updating [=============================>                 ] 122900/187002 2m44s
13:02:32     INFO - updating [=============================>                 ] 123300/187002 2m43s
13:02:32     INFO - updating [==============================>                ] 123700/187002 2m42s
13:02:32     INFO - updating [==============================>                ] 123900/187002 2m42s
13:02:32     INFO - updating [==============================>                ] 124800/187002 2m39s
13:02:32     INFO - updating [==============================>                ] 125000/187002 2m39s
13:02:32     INFO - updating [==============================>                ] 125600/187002 2m37s
13:02:32     INFO - updating [==============================>                ] 126300/187002 2m35s
13:02:32     INFO - updating [==============================>                ] 126700/187002 2m34s
13:02:32     INFO - updating [==============================>                ] 127000/187002 2m34s
13:02:32     INFO - updating [==============================>                ] 127200/187002 2m34s
13:02:32     INFO - updating [===============================>               ] 127400/187002 2m33s
13:02:32     INFO - updating [===============================>               ] 128100/187002 2m31s
13:02:32     INFO - updating [===============================>               ] 128300/187002 2m31s
13:02:32     INFO - updating [===============================>               ] 128700/187002 2m30s
13:02:32     INFO - updating [===============================>               ] 129300/187002 2m29s
13:02:32     INFO - updating [===============================>               ] 129800/187002 2m28s
13:02:32     INFO - updating [===============================>               ] 130100/187002 2m27s
13:02:32     INFO - updating [===============================>               ] 130500/187002 2m26s
13:02:32     INFO - updating [===============================>               ] 131200/187002 2m24s
13:02:32     INFO - updating [================================>              ] 131300/187002 2m25s
13:02:32     INFO - updating [================================>              ] 131700/187002 2m24s
13:02:32     INFO - updating [================================>              ] 132000/187002 2m23s
13:02:32     INFO - updating [================================>              ] 132600/187002 2m22s
13:02:32     INFO - updating [================================>              ] 133000/187002 2m21s
13:02:32     INFO - updating [================================>              ] 133600/187002 2m19s
13:02:32     INFO - updating [================================>              ] 134200/187002 2m17s
13:02:32     INFO - updating [================================>              ] 134600/187002 2m16s
13:02:32     INFO - updating [================================>              ] 135100/187002 2m15s
13:02:32     INFO - updating [=================================>             ] 135400/187002 2m14s
13:02:32     INFO - updating [=================================>             ] 135800/187002 2m13s
13:02:32     INFO - updating [=================================>             ] 136200/187002 2m12s
13:02:32     INFO - updating [=================================>             ] 137000/187002 2m10s
13:02:32     INFO - updating [=================================>             ] 137600/187002 2m08s
13:02:32     INFO - updating [=================================>             ] 138000/187002 2m07s
13:02:32     INFO - updating [=================================>             ] 138800/187002 2m06s
13:02:32     INFO - updating [=================================>             ] 139100/187002 2m05s
13:02:32     INFO - updating [==================================>            ] 139700/187002 2m04s
13:02:32     INFO - updating [==================================>            ] 139900/187002 2m04s
13:02:32     INFO - updating [==================================>            ] 140300/187002 2m03s
13:02:32     INFO - updating [==================================>            ] 140900/187002 2m01s
13:02:32     INFO - updating [==================================>            ] 141200/187002 2m01s
13:02:32     INFO - updating [==================================>            ] 141700/187002 2m00s
13:02:32     INFO - updating [==================================>            ] 142400/187002 1m58s
13:02:32     INFO - updating [==================================>            ] 142500/187002 1m59s
13:02:32     INFO - updating [===================================>           ] 143400/187002 1m56s
13:02:32     INFO - updating [===================================>           ] 143700/187002 1m55s
13:02:32     INFO - updating [===================================>           ] 144200/187002 1m54s
13:02:32     INFO - updating [===================================>           ] 144600/187002 1m53s
13:02:32     INFO - updating [===================================>           ] 144900/187002 1m52s
13:02:32     INFO - updating [===================================>           ] 145500/187002 1m50s
13:02:32     INFO - updating [===================================>           ] 146000/187002 1m49s
13:02:32     INFO - updating [===================================>           ] 146300/187002 1m49s
13:02:32     INFO - updating [===================================>           ] 146700/187002 1m48s
13:02:32     INFO - updating [====================================>          ] 147700/187002 1m45s
13:02:32     INFO - updating [====================================>          ] 148000/187002 1m44s
13:02:32     INFO - updating [====================================>          ] 148300/187002 1m44s
13:02:32     INFO - updating [====================================>          ] 149000/187002 1m42s
13:02:32     INFO - updating [====================================>          ] 149200/187002 1m42s
13:02:32     INFO - updating [====================================>          ] 149900/187002 1m40s
13:02:32     INFO - updating [====================================>          ] 150600/187002 1m38s
13:02:32     INFO - updating [=====================================>         ] 151300/187002 1m36s
13:02:32     INFO - updating [=====================================>         ] 151900/187002 1m34s
13:02:32     INFO - updating [=====================================>         ] 152600/187002 1m32s
13:02:32     INFO - updating [=====================================>         ] 153300/187002 1m30s
13:02:32     INFO - updating [=====================================>         ] 154000/187002 1m28s
13:02:32     INFO - updating [=====================================>         ] 154900/187002 1m26s
13:02:32     INFO - updating [======================================>        ] 155500/187002 1m24s
13:02:32     INFO - updating [======================================>        ] 156400/187002 1m21s
13:02:32     INFO - updating [======================================>        ] 157100/187002 1m19s
13:02:32     INFO - updating [======================================>        ] 157400/187002 1m19s
13:02:32     INFO - updating [======================================>        ] 157900/187002 1m17s
13:02:32     INFO - updating [======================================>        ] 158400/187002 1m16s
13:02:32     INFO - updating [======================================>        ] 158600/187002 1m16s
13:02:32     INFO - updating [=======================================>       ] 159300/187002 1m14s
13:02:32     INFO - updating [=======================================>       ] 160000/187002 1m12s
13:02:32     INFO - updating [=======================================>       ] 160500/187002 1m11s
13:02:32     INFO - updating [=======================================>       ] 161200/187002 1m09s
13:02:32     INFO - updating [=======================================>       ] 162000/187002 1m06s
13:02:32     INFO - updating [=======================================>       ] 162400/187002 1m05s
13:02:32     INFO - updating [=======================================>       ] 163100/187002 1m03s
13:02:32     INFO - updating [========================================>      ] 163400/187002 1m03s
13:02:32     INFO - updating [========================================>      ] 163800/187002 1m02s
13:02:32     INFO - updating [========================================>      ] 164500/187002 1m00s
13:02:32     INFO - updating [==========================================>      ] 165100/187002 58s
13:02:32     INFO - updating [==========================================>      ] 165700/187002 57s
13:02:32     INFO - updating [==========================================>      ] 166200/187002 55s
13:02:32     INFO - updating [==========================================>      ] 166900/187002 53s
13:02:32     INFO - updating [==========================================>      ] 167400/187002 52s
13:02:32     INFO - updating [===========================================>     ] 168100/187002 50s
13:02:32     INFO - updating [===========================================>     ] 168300/187002 50s
13:02:32     INFO - updating [===========================================>     ] 169000/187002 48s
13:02:32     INFO - updating [===========================================>     ] 169600/187002 46s
13:02:32     INFO - updating [===========================================>     ] 170300/187002 44s
13:02:32     INFO - updating [===========================================>     ] 170600/187002 44s
13:02:32     INFO - updating [===========================================>     ] 171000/187002 43s
13:02:32     INFO - updating [===========================================>     ] 171400/187002 42s
13:02:32     INFO - updating [============================================>    ] 171900/187002 40s
13:02:32     INFO - updating [============================================>    ] 172500/187002 39s
13:02:32     INFO - updating [============================================>    ] 173100/187002 37s
13:02:32     INFO - updating [============================================>    ] 173700/187002 35s
13:02:32     INFO - updating [============================================>    ] 174500/187002 33s
13:02:32     INFO - updating [============================================>    ] 174900/187002 32s
13:02:32     INFO - updating [============================================>    ] 175300/187002 31s
13:02:32     INFO - updating [=============================================>   ] 175900/187002 30s
13:02:32     INFO - updating [=============================================>   ] 176500/187002 28s
13:02:32     INFO - updating [=============================================>   ] 176800/187002 27s
13:02:32     INFO - updating [=============================================>   ] 177100/187002 27s
13:02:32     INFO - updating [=============================================>   ] 177900/187002 24s
13:02:32     INFO - updating [=============================================>   ] 178100/187002 24s
13:02:32     INFO - updating [=============================================>   ] 178500/187002 23s
13:02:32     INFO - updating [=============================================>   ] 179100/187002 21s
13:02:32     INFO - updating [==============================================>  ] 179600/187002 20s
13:02:32     INFO - updating [==============================================>  ] 179900/187002 19s
13:02:32     INFO - updating [==============================================>  ] 180200/187002 18s
13:02:32     INFO - updating [==============================================>  ] 180800/187002 17s
13:02:32     INFO - updating [==============================================>  ] 181100/187002 16s
13:02:32     INFO - updating [==============================================>  ] 181500/187002 15s
13:02:32     INFO - updating [==============================================>  ] 181600/187002 15s
13:02:32     INFO - updating [==============================================>  ] 182000/187002 14s
13:02:32     INFO - updating [==============================================>  ] 182500/187002 13s
13:02:32     INFO - updating [==============================================>  ] 182700/187002 12s
13:02:32     INFO - updating [===============================================> ] 183200/187002 11s
13:02:32     INFO - updating [===============================================> ] 183600/187002 10s
13:02:32     INFO - updating [===============================================> ] 184400/187002 07s
13:02:32     INFO - updating [===============================================> ] 184700/187002 07s
13:02:32     INFO - updating [===============================================> ] 184800/187002 06s
13:02:32     INFO - updating [===============================================> ] 185200/187002 05s
13:02:32     INFO - updating [===============================================> ] 185700/187002 04s
13:02:32     INFO - updating [===============================================> ] 186000/187002 03s
13:02:32     INFO - updating [===============================================> ] 186500/187002 02s
13:02:32     INFO - updating [===============================================> ] 187000/187002 01s
13:02:32     INFO -                                                                                
13:02:32     INFO - 187002 files updated, 0 files merged, 0 files removed, 0 files unresolved
13:02:32     INFO -  updated to 508966268fab932a33c9c77be039b6a1b8d3d4ec
13:02:32     INFO - Return code: 0
13:02:32     INFO - Setting buildbot property comments to Bug 1362364: Lazily load the certificate database into the add-ons manager. r=rhelmer
13:02:32     INFO - 
13:02:32     INFO - The lazy loading is a little more complex because we want this to be a constant
13:02:32     INFO - in the scope so extensions can't trivially replace it. This also changes the
13:02:32     INFO - test to be more like the proof of concept from bug 1244248.
13:02:32     INFO - 
13:02:32     INFO - MozReview-Commit-ID: 2P890uRY1Si
13:02:32     INFO - Writing buildbot properties ['comments'] to c:\builds\moz2_slave\autoland-w32-d-000000000000000\properties\comments
13:02:32     INFO - Writing to file c:\builds\moz2_slave\autoland-w32-d-000000000000000\properties\comments
13:02:32     INFO - Contents:
13:02:32     INFO -  comments:Bug 1362364: Lazily load the certificate database into the add-ons manager. r=rhelmer
13:02:32     INFO -  
13:02:32     INFO -  The lazy loading is a little more complex because we want this to be a constant
13:02:32     INFO -  in the scope so extensions can't trivially replace it. This also changes the
13:02:32     INFO -  test to be more like the proof of concept from bug 1244248.
13:02:32     INFO -  
13:02:32     INFO -  MozReview-Commit-ID: 2P890uRY1Si
13:02:32     INFO - Setting buildbot property got_revision to 508966268fab932a33c9c77be039b6a1b8d3d4ec
13:02:32     INFO - Writing buildbot properties ['got_revision'] to c:\builds\moz2_slave\autoland-w32-d-000000000000000\properties\got_revision
13:02:32     INFO - Writing to file c:\builds\moz2_slave\autoland-w32-d-000000000000000\properties\got_revision
13:02:32     INFO - Contents:
13:02:32     INFO -  got_revision:508966268fab932a33c9c77be039b6a1b8d3d4ec
13:02:32     INFO - [mozharness: 2017-05-11 20:02:32.602000Z] Finished checkout-sources step (success)
13:02:32     INFO - [mozharness: 2017-05-11 20:02:32.602000Z] Skipping setup-mock step.
13:02:32     INFO - [mozharness: 2017-05-11 20:02:32.602000Z] Running build step.
13:02:32     INFO - Running main action method: build
13:02:32     INFO - removing old packages...
13:02:32     INFO - There wasn't any old packages to remove.
13:02:32     INFO - Using in-tree mozconfig
13:02:32     INFO - Reading from file c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\src\browser/config/mozconfigs/win32/debug
13:02:32     INFO - Contents:
13:02:32     INFO -  . "$topsrcdir/build/mozconfig.win-common"
13:02:32     INFO -  MOZ_AUTOMATION_L10N_CHECK=0
13:02:32     INFO -  . "$topsrcdir/browser/config/mozconfigs/common"
13:02:32     INFO -  
13:02:32     INFO -  ac_add_options --enable-debug
13:02:32     INFO -  ac_add_options --enable-dmd
13:02:32     INFO -  ac_add_options --enable-profiling  # needed for --enable-dmd to work on Windows
13:02:32     INFO -  ac_add_options --enable-verify-mar
13:02:32     INFO -  
13:02:32     INFO -  # Needed to enable breakpad in application.ini
13:02:32     INFO -  export MOZILLA_OFFICIAL=1
13:02:32     INFO -  
13:02:32     INFO -  # Enable Telemetry
13:02:32     INFO -  export MOZ_TELEMETRY_REPORTING=1
13:02:32     INFO -  
13:02:32     INFO -  . $topsrcdir/build/win32/mozconfig.vs-latest
13:02:32     INFO -  
13:02:32     INFO -  # Package js shell.
13:02:32     INFO -  export MOZ_PACKAGE_JSSHELL=1
13:02:32     INFO -  
13:02:32     INFO -  ac_add_options --with-branding=browser/branding/nightly
13:02:32     INFO -  
13:02:32     INFO -  . "$topsrcdir/build/mozconfig.common.override"
13:02:32     INFO -  . "$topsrcdir/build/mozconfig.cache"
13:02:32     INFO - mozconfig content:
13:02:32     INFO - . "$topsrcdir/build/mozconfig.win-common"
13:02:32     INFO - MOZ_AUTOMATION_L10N_CHECK=0
13:02:32     INFO - . "$topsrcdir/browser/config/mozconfigs/common"
13:02:32     INFO - 
13:02:32     INFO - ac_add_options --enable-debug
13:02:32     INFO - ac_add_options --enable-dmd
13:02:32     INFO - ac_add_options --enable-profiling  # needed for --enable-dmd to work on Windows
13:02:32     INFO - ac_add_options --enable-verify-mar
13:02:32     INFO - 
13:02:32     INFO - # Needed to enable breakpad in application.ini
13:02:32     INFO - export MOZILLA_OFFICIAL=1
13:02:32     INFO - 
13:02:32     INFO - # Enable Telemetry
13:02:32     INFO - export MOZ_TELEMETRY_REPORTING=1
13:02:32     INFO - 
13:02:32     INFO - . $topsrcdir/build/win32/mozconfig.vs-latest
13:02:32     INFO - 
13:02:32     INFO - # Package js shell.
13:02:32     INFO - export MOZ_PACKAGE_JSSHELL=1
13:02:32     INFO - 
13:02:32     INFO - ac_add_options --with-branding=browser/branding/nightly
13:02:32     INFO - 
13:02:32     INFO - . "$topsrcdir/build/mozconfig.common.override"
13:02:32     INFO - . "$topsrcdir/build/mozconfig.cache"
13:02:32     INFO - Copying c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\src\browser/config/mozconfigs/win32/debug to c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\src\.mozconfig
13:02:32     INFO - Using buildbot properties:
13:02:32     INFO - {
13:02:32     INFO -     "project": "", 
13:02:32     INFO -     "product": "firefox", 
13:02:32     INFO -     "script_repo_revision": "production", 
13:02:32     INFO -     "scheduler": "autoland-firefox", 
13:02:32     INFO -     "repository": "", 
13:02:32     INFO -     "buildername": "WINNT 5.2 autoland leak test build", 
13:02:32     INFO -     "buildid": "20170511122625", 
13:02:32     INFO -     "basedir": "/c/builds/moz2_slave/autoland-w32-d-000000000000000", 
13:02:32     INFO -     "buildnumber": 1143, 
13:02:32     INFO -     "platform": "win32-debug", 
13:02:32     INFO -     "master": "http://buildbot-master94.bb.releng.use1.mozilla.com:8001/", 
13:02:32     INFO -     "branch": "autoland", 
13:02:32     INFO -     "revision": "508966268fab932a33c9c77be039b6a1b8d3d4ec", 
13:02:32     INFO -     "slavename": "b-2008-spot-057", 
13:02:32     INFO -     "builduid": "46d47989ca974a39a8633424fb4d42d5", 
13:02:32     INFO -     "repo_path": "integration/autoland"
13:02:32     INFO - }
13:02:32     INFO - ['python2.7', '-u', 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\src\\mach', 'artifact', 'toolchain', '-v', '--retry', '4', '--tooltool-manifest', 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\src\\browser/config/tooltool-manifests/win32/releng.manifest', '--tooltool-url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', '--cache-dir', 'c:/builds/tooltool_cache']
13:02:32     INFO - Running command: ['python2.7', '-u', 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\src\\mach', 'artifact', 'toolchain', '-v', '--retry', '4', '--tooltool-manifest', 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\src\\browser/config/tooltool-manifests/win32/releng.manifest', '--tooltool-url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', '--cache-dir', 'c:/builds/tooltool_cache'] in c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\src
13:02:32     INFO - Copy/paste: python2.7 -u c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\src\mach artifact toolchain -v --retry 4 --tooltool-manifest c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\src\browser/config/tooltool-manifests/win32/releng.manifest --tooltool-url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok --cache-dir c:/builds/tooltool_cache
13:02:32     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:02:32     INFO -  'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:02:32     INFO -  'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv',
13:02:32     INFO -  'BINSCOPE': 'C:/Program Files (x86)/Microsoft/SDL BinScope/BinScope.exe',
13:02:32     INFO -  'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve',
13:02:32     INFO -  'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey',
13:02:32     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
13:02:32     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
13:02:32     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
13:02:32     INFO -  'COMPUTERNAME': 'B-2008-SPOT-057',
13:02:32     INFO -  'COMSPEC': 'C:\\Windows\\system32\\cmd.exe',
13:02:32     INFO -  'CVS_RSH': 'ssh',
13:02:32     INFO -  'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\',
13:02:32     INFO -  'EDITOR': 'emacs.exe',
13:02:32     INFO -  'FP_NO_HOST_CHECK': 'NO',
13:02:32     INFO -  'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared',
13:02:32     INFO -  'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared',
13:02:32     INFO -  'HOME': 'c:/Users/cltbld',
13:02:32     INFO -  'HOMEDRIVE': 'C:',
13:02:32     INFO -  'HOMEPATH': '\\',
13:02:32     INFO -  'HOSTTYPE': 'i686',
13:02:32     INFO -  'IDLEIZER_HALT_ON_IDLE': 'true',
13:02:32     INFO -  'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc',
13:02:32     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:02:32     INFO -  'LOG': '"c:\\runner\\buildbot-startup.log"',
13:02:32     INFO -  'LOGNAME': 'cltbld',
13:02:32     INFO -  'LOGONSERVER': '\\\\B-2008-SPOT-057',
13:02:32     INFO -  'MACHTYPE': 'i686-pc-msys',
13:02:32     INFO -  'MAKE_MODE': 'unix',
13:02:32     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build',
13:02:32     INFO -  'MOZBUILD_STATE_PATH': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\.mozbuild',
13:02:32     INFO -  'MOZILLABUILD': 'C:\\mozilla-build',
13:02:32     INFO -  'MOZ_AUTOMATION': '1',
13:02:32     INFO -  'MOZ_BUILD_DATE': '20170511122625',
13:02:32     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:02:32     INFO -  'MOZ_OBJDIR': 'obj-firefox',
13:02:32     INFO -  'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110',
13:02:32     INFO -  'MOZ_SIGN_CMD': 'python c:\\\\\\\\builds\\\\\\\\moz2_slave\\\\\\\\autoland-w32-d-000000000000000\\\\\\\\build\\\\\\\\tools\\\\\\\\release\\\\\\\\signing\\\\\\\\signtool.py --cachedir c:\\\\\\\\builds\\\\\\\\moz2_slave\\\\\\\\autoland-w32-d-000000000000000\\\\\\\\build\\\\\\\\signing_cache -t c:\\\\\\\\builds\\\\\\\\moz2_slave\\\\\\\\autoland-w32-d-000000000000000\\\\\\\\token -n c:\\\\\\\\builds\\\\\\\\moz2_slave\\\\\\\\autoland-w32-d-000000000000000\\\\\\\\nonce -c c:\\\\\\\\builds\\\\\\\\moz2_slave\\\\\\\\autoland-w32-d-000000000000000\\\\\\\\build\\\\\\\\tools\\\\\\\\release\\\\\\\\signing\\\\\\\\host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110',
13:02:32     INFO -  'MOZ_SOURCE_REPO': 'https://hg.mozilla.org/integration/autoland',
13:02:32     INFO -  'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64',
13:02:32     INFO -  'MSYSTEM': 'MINGW32',
13:02:32     INFO -  'NUMBER_OF_PROCESSORS': '16',
13:02:32     INFO -  'OLDPWD': 'c:/Users/cltbld',
13:02:32     INFO -  'OS': 'Windows_NT',
13:02:32     INFO -  'OSTYPE': 'msys',
13:02:32     INFO -  'OS_VERSION': '2008',
13:02:32     INFO -  'PATH': 'C:/mozilla-build/nsis-3.01;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:\\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',
13:02:32     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:02:32     INFO -  'POST_UPLOAD_CMD': 'post_upload.py --tinderbox-builds-dir autoland-win32-debug -p firefox -i 20170511122625 --revision 508966268fab932a33c9c77be039b6a1b8d3d4ec --release-to-tinderbox-dated-builds',
13:02:32     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
13:02:32     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
13:02:32     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel',
13:02:32     INFO -  'PROCESSOR_LEVEL': '6',
13:02:32     INFO -  'PROCESSOR_REVISION': '3f02',
13:02:32     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
13:02:32     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
13:02:32     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
13:02:32     INFO -  'PROGRAMW6432': 'C:\\Program Files',
13:02:32     INFO -  'PROMPT': '$P$G',
13:02:32     INFO -  'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\buildprops.json',
13:02:32     INFO -  'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ',
13:02:32     INFO -  'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\',
13:02:32     INFO -  'PUBLIC': 'C:\\Users\\Public',
13:02:32     INFO -  'PWD': 'c:/Users/cltbld',
13:02:32     INFO -  'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg',
13:02:32     INFO -  'SHELL': 'C:/mozilla-build/msys/bin/sh',
13:02:32     INFO -  'SHLVL': '1',
13:02:32     INFO -  'SSH_AGENT_PID': '3556',
13:02:32     INFO -  'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620',
13:02:32     INFO -  'SYSTEMDRIVE': 'C:',
13:02:32     INFO -  'SYSTEMROOT': 'C:\\Windows',
13:02:32     INFO -  'TEMP': 'C:/Users/cltbld/AppData/Local/Temp',
13:02:32     INFO -  'TERM': 'cygwin',
13:02:32     INFO -  'TINDERBOX_OUTPUT': '1',
13:02:32     INFO -  'TMP': 'C:/Users/cltbld/AppData/Local/Temp',
13:02:32     INFO -  'TOOLTOOL_CACHE': 'c:/builds/tooltool_cache',
13:02:32     INFO -  'TOOLTOOL_HOME': '/c/builds',
13:02:32     INFO -  'UPLOAD_HOST': 'upload.ffxbld.productdelivery.prod.mozaws.net',
13:02:32     INFO -  'UPLOAD_SSH_KEY': '/c/Users/cltbld/.ssh/ffxbld_rsa',
13:02:32     INFO -  'UPLOAD_TO_TEMP': '1',
13:02:32     INFO -  'UPLOAD_USER': 'ffxbld',
13:02:32     INFO -  'USERDOMAIN': 'B-2008-SPOT-057',
13:02:32     INFO -  'USERNAME': 'cltbld',
13:02:32     INFO -  'USERPROFILE': 'C:\\Users\\cltbld',
13:02:32     INFO -  'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\',
13:02:32     INFO -  'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\',
13:02:32     INFO -  'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\',
13:02:32     INFO -  'WINDIR': 'C:\\Windows',
13:02:32     INFO -  'WINDOWS_TRACING_FLAGS': '3',
13:02:32     INFO -  'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:02:32     INFO -  'WIX_351728_PATH': 'c:/mozilla-build/wix-351728',
13:02:32     INFO -  'XPCOM_DEBUG_BREAK': 'stack-and-abort',
13:02:32     INFO -  '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'}
13:02:32    FATAL - caught OS error 2: The system cannot find the file specified while running ['python2.7', '-u', 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\src\\mach', 'artifact', 'toolchain', '-v', '--retry', '4', '--tooltool-manifest', 'c:\\builds\\moz2_slave\\autoland-w32-d-000000000000000\\build\\src\\browser/config/tooltool-manifests/win32/releng.manifest', '--tooltool-url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', '--cache-dir', 'c:/builds/tooltool_cache']
13:02:32    FATAL - Running post_fatal callback...
13:02:32    ERROR - setting return code to 2 because fatal was called
13:02:32  WARNING - setting return code to 2
13:02:32    FATAL - Exiting -1
13:02:32     INFO - [mozharness: 2017-05-11 20:02:32.714000Z] Finished build step (failed)
13:02:32     INFO - Running post-run listener: _summarize
13:02:32    ERROR - # TBPL FAILURE #
13:02:32     INFO - [mozharness: 2017-05-11 20:02:32.714000Z] FxDesktopBuild summary:
13:02:32    ERROR - # TBPL FAILURE #
13:02:32     INFO - Running post-run listener: copy_logs_to_upload_dir
13:02:32     INFO - Copying logs to upload dir...
13:02:32     INFO - mkdir: c:\builds\moz2_slave\autoland-w32-d-000000000000000\build\upload\logs
program finished with exit code -1
elapsedTime=1391.150000
========= master_lag: 0.05 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 23 mins, 11 secs) (at 2017-05-11 13:02:34.784424) =========

========= Started set props: buildid stage_platform comments MozReview-Commit-ID got_revision builduid (results: 0, elapsed: 0 secs) (at 2017-05-11 13:02:34.788185) =========
'bash' '-c' 'for file in `ls -1`; do cat $file; done'
 in dir c:\builds\moz2_slave\autoland-w32-d-000000000000000\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-057
  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-057
  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:\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 63 Stepping 2, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3f02
  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=3556
  SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620
  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-057
  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:20170511122625
builduid:46d47989ca974a39a8633424fb4d42d5
comments:Bug 1362364: Lazily load the certificate database into the add-ons manager. r=rhelmer

The lazy loading is a little more complex because we want this to be a constant
in the scope so extensions can't trivially replace it. This also changes the
test to be more like the proof of concept from bug 1244248.

MozReview-Commit-ID: 2P890uRY1Si
got_revision:508966268fab932a33c9c77be039b6a1b8d3d4ec
stage_platform:win32-debug
program finished with exit code 0
elapsedTime=0.123000
buildid: '20170511122625'
stage_platform: 'win32-debug'
comments: 'Bug 1362364: Lazily load the certificate database into the add-ons manager. r=rhelmer'
MozReview-Commit-ID: '2P890uRY1Si'
got_revision: '508966268fab932a33c9c77be039b6a1b8d3d4ec'
builduid: '46d47989ca974a39a8633424fb4d42d5'
========= master_lag: 0.01 =========
========= Finished set props: buildid stage_platform comments MozReview-Commit-ID got_revision builduid (results: 0, elapsed: 0 secs) (at 2017-05-11 13:02:34.919465) =========

========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 13:02:34.920462) =========
'rm' '-f' 'oauth.txt'
 in dir c:\builds\moz2_slave\autoland-w32-d-000000000000000\. (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-057
  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-057
  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:\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 63 Stepping 2, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3f02
  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=3556
  SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-TFIOMw1620/agent.1620
  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-057
  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.105000
========= master_lag: 0.01 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 13:02:35.033127) =========

========= Started reboot slave lost (results: 0, elapsed: 2 secs) (at 2017-05-11 13:02:35.034093) =========

========= Finished reboot slave lost (results: 0, elapsed: 2 secs) (at 2017-05-11 13:02:37.826919) =========

========= Total master_lag: 0.35 =========