builder: larch-win64 slave: b-2008-spot-106 starttime: 1476216488.6 results: failure (2) buildid: 20161011124447 builduid: 24735c14cd0c41d2856c32aa24e48f22 revision: 15a5f3920481 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:08.603481) ========= master: http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:08.613707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:08.614014) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:08.805999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-11 13:08:08.806369) ========= '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\l-w64-000000000000000000000000\. (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-106 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-106 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=8 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\hg;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=3760 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656 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-106 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 --2016-10-11 13:08: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.7K=0.5s 2016-10-11 13:08:11 (24.7 KB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=4.450000 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-11 13:08:13.303476) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:13.307668) ========= 'rm' '-rf' 'scripts' 'properties' in dir c:\builds\moz2_slave\l-w64-000000000000000000000000\. (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-106 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-106 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=8 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\hg;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=3760 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656 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-106 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.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:13.449051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-11 13:08:13.450306) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo projects/larch --rev 15a5f3920481be2c6cacf4938eedc28c77d37077 --destination scripts --debug' in dir c:\builds\moz2_slave\l-w64-000000000000000000000000\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 15a5f3920481be2c6cacf4938eedc28c77d37077 --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-106 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-106 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=8 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\hg;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=3760 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656 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-106 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 2016-10-11 13:08:12,089 truncating revision to first 12 chars 2016-10-11 13:08:12,089 Setting DEBUG logging. 2016-10-11 13:08:12,089 attempt 1/10 2016-10-11 13:08:12,089 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/15a5f3920481?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 13:08:12,668 unpacking tar archive at: larch-15a5f3920481/testing/mozharness/ 2016-10-11 13:08:13,476 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=2.452000 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-11 13:08:15.952152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:15.953140) ========= script_repo_revision: 15a5f3920481be2c6cacf4938eedc28c77d37077 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:15.953519) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:15.953811) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:15.986046) ========= ========= Started remove old nonce (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:15.986380) ========= 'rm' '-f' 'nonce' in dir c:\builds\moz2_slave\l-w64-000000000000000000000000\. (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-106 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-106 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=8 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\hg;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=3760 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656 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-106 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.04 ========= ========= Finished remove old nonce (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:16.131173) ========= ========= Started downloading to token (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:16.132117) ========= Slave: b-2008-spot-106 IP: 10.132.53.13 Duration: 25200 URI: https://mac-v2-signing6.srv.releng.scl3.mozilla.com:9110/token ========= Finished downloading to token (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:16.387052) ========= ========= Started set props: toolsdir (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:16.387461) ========= 'bash' '-c' 'pwd' in dir c:\builds\moz2_slave\l-w64-000000000000000000000000\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-106 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-106 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=8 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\hg;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=3760 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656 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-106 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/l-w64-000000000000000000000000/scripts program finished with exit code 0 elapsedTime=0.105000 toolsdir: '/c/builds/moz2_slave/l-w64-000000000000000000000000/scripts' ========= master_lag: 0.02 ========= ========= Finished set props: toolsdir (results: 0, elapsed: 0 secs) (at 2016-10-11 13:08:16.511768) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 1 hrs, 43 mins, 48 secs) (at 2016-10-11 13:08:16.512718) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/fx_desktop_build.py' '--config' 'builds/releng_base_windows_64_builds.py' '--config' 'balrog/production.py' '--branch' 'larch' '--build-pool' 'production' in dir c:\builds\moz2_slave\l-w64-000000000000000000000000\. (timeout 10800 secs) (maxTime 27000 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/fx_desktop_build.py', '--config', 'builds/releng_base_windows_64_builds.py', '--config', 'balrog/production.py', '--branch', 'larch', '--build-pool', 'production'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming APR_ICONV_PATH=c:/mozilla-build/svn-win32-1.6.3/iconv BUILDBOT_PATH=C:\mozilla-build\buildbotve CHOCOLATEYINSTALL=C:\ProgramData\chocolatey COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=B-2008-SPOT-106 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-106 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:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110 MOZ_SIGN_CMD=python /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/l-w64-000000000000000000000000/signing_cache -t /c/builds/moz2_slave/l-w64-000000000000000000000000/token -n /c/builds/moz2_slave/l-w64-000000000000000000000000/nonce -c /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110 MOZ_TOOLS=C:\mozilla-build\moztools-x64 MSYSTEM=MINGW32 NUMBER_OF_PROCESSORS=8 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\nsis-3.0b1;C:\mozilla-build\nsis-2.46u;C:\mozilla-build\python27;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\hg;c:\mozilla-build\buildbotve\Scripts;c:\ProgramData\chocolatey\bin;.;c:\opt\runner;c:\mozilla-build\buildbotve;c:\mozilla-build\python27;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;.;C:\mozilla-build\msys\local\bin;c:\mozilla-build\moztools-x64\bin;c:\mozilla-build\vim\vim72 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PDBSTR_PATH=/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 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/l-w64-000000000000000000000000/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=3760 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656 SYSTEMDRIVE=C: SYSTEMROOT=C:\Windows TEMP=C:/Users/cltbld/AppData/Local/Temp TERM=cygwin TINDERBOX_OUTPUT=1 TMP=C:/Users/cltbld/AppData/Local/Temp USERDOMAIN=B-2008-SPOT-106 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 13:08:15 INFO - MultiFileLogger online at 20161011 13:08:15 in c:\builds\moz2_slave\l-w64-000000000000000000000000 13:08:15 INFO - Script was run with '--branch larch' and 'larch' matches a key in 'builds/branch_specifics.py'. Updating self.config with items from that key's value. 13:08:15 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. 13:08:15 INFO - To generate a config file based upon options passed and config files used, run script as before but extend options with "--dump-config" 13:08:15 INFO - For a diff of where self.config got its items, run the script again as before but extend options with: "--dump-config-hierarchy" 13:08:15 INFO - Both --dump-config and --dump-config-hierarchy don't actually run any actions. 13:08:15 INFO - We are running this in buildbot, grab the build props 13:08:15 INFO - Using buildbot properties: 13:08:15 INFO - { 13:08:15 INFO - "project": "", 13:08:15 INFO - "product": "firefox", 13:08:15 INFO - "script_repo_revision": "production", 13:08:15 INFO - "scheduler": "larch-firefox", 13:08:15 INFO - "repository": "", 13:08:15 INFO - "buildername": "WINNT 6.1 x86-64 larch build", 13:08:15 INFO - "buildid": "20161011124447", 13:08:15 INFO - "basedir": "/c/builds/moz2_slave/l-w64-000000000000000000000000", 13:08:15 INFO - "buildnumber": 0, 13:08:15 INFO - "platform": "win64", 13:08:15 INFO - "master": "http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/", 13:08:15 INFO - "branch": "larch", 13:08:15 INFO - "revision": "15a5f3920481be2c6cacf4938eedc28c77d37077", 13:08:15 INFO - "slavename": "b-2008-spot-106", 13:08:15 INFO - "builduid": "24735c14cd0c41d2856c32aa24e48f22", 13:08:15 INFO - "repo_path": "projects/larch" 13:08:15 INFO - } 13:08:15 INFO - Setting buildbot property stage_platform to win64 13:08:15 INFO - mkdir: c:\builds\moz2_slave\l-w64-000000000000000000000000\properties 13:08:15 INFO - Writing buildbot properties ['stage_platform'] to c:\builds\moz2_slave\l-w64-000000000000000000000000\properties\stage_platform 13:08:15 INFO - Writing to file c:\builds\moz2_slave\l-w64-000000000000000000000000\properties\stage_platform 13:08:15 INFO - Contents: 13:08:15 INFO - stage_platform:win64 13:08:15 WARNING - Try message not found. 13:08:15 INFO - Run as scripts/scripts/fx_desktop_build.py --config builds/releng_base_windows_64_builds.py --config balrog/production.py --branch larch --build-pool production 13:08:15 INFO - Determining buildid from buildbot properties 13:08:15 INFO - Setting buildbot property buildid to 20161011124447 13:08:15 INFO - Writing buildbot properties ['buildid'] to c:\builds\moz2_slave\l-w64-000000000000000000000000\properties\buildid 13:08:15 INFO - Writing to file c:\builds\moz2_slave\l-w64-000000000000000000000000\properties\buildid 13:08:15 INFO - Contents: 13:08:15 INFO - buildid:20161011124447 13:08:15 INFO - Determining builduid from buildbot properties 13:08:15 INFO - Setting buildbot property builduid to 24735c14cd0c41d2856c32aa24e48f22 13:08:15 INFO - Writing buildbot properties ['builduid'] to c:\builds\moz2_slave\l-w64-000000000000000000000000\properties\builduid 13:08:15 INFO - Writing to file c:\builds\moz2_slave\l-w64-000000000000000000000000\properties\builduid 13:08:15 INFO - Contents: 13:08:15 INFO - builduid:24735c14cd0c41d2856c32aa24e48f22 13:08:15 INFO - repo_path not in config. Using 'projects/larch' instead 13:08:15 INFO - Creating virtualenv c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv 13:08:15 INFO - mkdir: c:\builds\moz2_slave\l-w64-000000000000000000000000\build 13:08:15 INFO - Running command: ['c:\\mozilla-build\\python27\\python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\venv'] in c:\builds\moz2_slave\l-w64-000000000000000000000000\build 13:08:15 INFO - Copy/paste: c:\mozilla-build\python27\python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv 13:08:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:08:21 INFO - New python executable in c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Scripts\python.exe 13:08:25 INFO - Installing distribute................................................................................................................................................................................................done. 13:08:39 INFO - Installing pip..................................done. 13:08:39 INFO - Return code: 0 13:08:39 INFO - Getting output from command: ['c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\venv\\Scripts\\pip', '--version'] 13:08:39 INFO - Copy/paste: c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Scripts\pip --version 13:08:43 INFO - Reading from file tmpfile_stdout 13:08:43 INFO - Output received: 13:08:43 INFO - pip 8.1.2 from c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\lib\site-packages\pip-8.1.2-py2.7.egg (python 2.7) 13:08:43 INFO - Using _rmtree_windows ... 13:08:43 INFO - Using _rmtree_windows ... 13:08:43 INFO - Installing requests==2.8.1 into virtualenv c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv 13:08:43 INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\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 0x02218C58>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022EC278>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02441D40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0260B8F8>, '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 0x02319928>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0234B4B8>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build', 'env': {'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'USERNAME': 'cltbld', 'COMPUTERNAME': 'B-2008-SPOT-106', 'SYSTEMDRIVE': 'C:', 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 'USERDOMAIN': 'B-2008-SPOT-106', 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 'MOZ_AUTOMATION': '1', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'HOSTTYPE': 'i686', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel', 'CVS_RSH': 'ssh', 'LOGNAME': 'cltbld', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'SYSTEMROOT': 'C:\\Windows', 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'MSYSTEM': 'MINGW32', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'MAKE_MODE': 'unix', 'TERM': 'cygwin', 'SHELL': 'C:/mozilla-build/msys/bin/sh', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 'SHLVL': '1', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_ARCHITECTURE': 'x86', 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'EDITOR': 'emacs.exe', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'OSTYPE': 'msys', 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'SSH_AGENT_PID': '3760', 'HOME': 'c:/Users/cltbld', 'PROGRAMW6432': 'C:\\Program Files', 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 'TOOLTOOL_HOME': '/c/builds', 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 'PROMPT': '$P$G', 'WINDOWS_TRACING_FLAGS': '3', 'PROCESSOR_REVISION': '3f02', 'PROGRAMDATA': 'C:\\ProgramData', 'LOG': '"c:\\runner\\buildbot-startup.log"', 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656', 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\hg;c:\\mozilla-build\\buildbotve\\Scripts;c:\\ProgramData\\chocolatey\\bin;.;c:\\opt\\runner;c:\\mozilla-build\\buildbotve;c:\\mozilla-build\\python27;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\msys\\local\\bin;.;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\moztools-x64\\bin;c:\\mozilla-build\\vim\\vim72', 'IDLEIZER_HALT_ON_IDLE': 'true', 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 'TINDERBOX_OUTPUT': '1', 'LOGONSERVER': '\\\\B-2008-SPOT-106', 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/l-w64-000000000000000000000000/signing_cache -t /c/builds/moz2_slave/l-w64-000000000000000000000000/token -n /c/builds/moz2_slave/l-w64-000000000000000000000000/nonce -c /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'HOMEPATH': '\\', 'MOZILLABUILD': 'C:\\mozilla-build', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'FP_NO_HOST_CHECK': 'NO', 'WINDIR': 'C:\\Windows', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'HOMEDRIVE': 'C:', 'OS_VERSION': '2008', 'MOZBUILDDIR': 'C:\\mozilla-build', 'OLDPWD': 'c:/Users/cltbld', 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'c:/Users/cltbld', 'PROCESSOR_LEVEL': '6', 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'USERPROFILE': 'C:\\Users\\cltbld'}}, attempt #1 13:08:43 INFO - Running command: ['c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'requests==2.8.1'] in c:\builds\moz2_slave\l-w64-000000000000000000000000\build 13:08:43 INFO - Copy/paste: c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Scripts\pip install --timeout 120 requests==2.8.1 13:08:43 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:08:43 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:08:43 INFO - 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 13:08:43 INFO - 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 13:08:43 INFO - 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 13:08:43 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 13:08:43 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 13:08:43 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 13:08:43 INFO - 'COMPUTERNAME': 'B-2008-SPOT-106', 13:08:43 INFO - 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 13:08:43 INFO - 'CVS_RSH': 'ssh', 13:08:43 INFO - 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 13:08:43 INFO - 'EDITOR': 'emacs.exe', 13:08:43 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:08:43 INFO - 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 13:08:43 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 13:08:43 INFO - 'HOME': 'c:/Users/cltbld', 13:08:43 INFO - 'HOMEDRIVE': 'C:', 13:08:43 INFO - 'HOMEPATH': '\\', 13:08:43 INFO - 'HOSTTYPE': 'i686', 13:08:43 INFO - 'IDLEIZER_HALT_ON_IDLE': 'true', 13:08:43 INFO - 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 13:08:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:08:43 INFO - 'LOG': '"c:\\runner\\buildbot-startup.log"', 13:08:43 INFO - 'LOGNAME': 'cltbld', 13:08:43 INFO - 'LOGONSERVER': '\\\\B-2008-SPOT-106', 13:08:43 INFO - 'MACHTYPE': 'i686-pc-msys', 13:08:43 INFO - 'MAKE_MODE': 'unix', 13:08:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build', 13:08:43 INFO - 'MOZILLABUILD': 'C:\\mozilla-build', 13:08:43 INFO - 'MOZ_AUTOMATION': '1', 13:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:43 INFO - 'MOZ_OBJDIR': 'obj-firefox', 13:08:43 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 13:08:43 INFO - 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/l-w64-000000000000000000000000/signing_cache -t /c/builds/moz2_slave/l-w64-000000000000000000000000/token -n /c/builds/moz2_slave/l-w64-000000000000000000000000/nonce -c /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 13:08:43 INFO - 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 13:08:43 INFO - 'MSYSTEM': 'MINGW32', 13:08:43 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:08:43 INFO - 'OLDPWD': 'c:/Users/cltbld', 13:08:43 INFO - 'OS': 'Windows_NT', 13:08:43 INFO - 'OSTYPE': 'msys', 13:08:43 INFO - 'OS_VERSION': '2008', 13:08:43 INFO - 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\hg;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:08:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:08:43 INFO - 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 13:08:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:08:43 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 13:08:43 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel', 13:08:43 INFO - 'PROCESSOR_LEVEL': '6', 13:08:43 INFO - 'PROCESSOR_REVISION': '3f02', 13:08:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:08:43 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 13:08:43 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 13:08:43 INFO - 'PROGRAMW6432': 'C:\\Program Files', 13:08:43 INFO - 'PROMPT': '$P$G', 13:08:43 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\buildprops.json', 13:08:43 INFO - 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 13:08:43 INFO - 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 13:08:43 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:08:43 INFO - 'PWD': 'c:/Users/cltbld', 13:08:43 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:08:43 INFO - 'SHELL': 'C:/mozilla-build/msys/bin/sh', 13:08:43 INFO - 'SHLVL': '1', 13:08:43 INFO - 'SSH_AGENT_PID': '3760', 13:08:43 INFO - 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656', 13:08:43 INFO - 'SYSTEMDRIVE': 'C:', 13:08:43 INFO - 'SYSTEMROOT': 'C:\\Windows', 13:08:43 INFO - 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 13:08:43 INFO - 'TERM': 'cygwin', 13:08:43 INFO - 'TINDERBOX_OUTPUT': '1', 13:08:43 INFO - 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 13:08:43 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 13:08:43 INFO - 'TOOLTOOL_HOME': '/c/builds', 13:08:43 INFO - 'USERDOMAIN': 'B-2008-SPOT-106', 13:08:43 INFO - 'USERNAME': 'cltbld', 13:08:43 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:08:43 INFO - 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 13:08:43 INFO - 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 13:08:43 INFO - 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 13:08:43 INFO - 'WINDIR': 'C:\\Windows', 13:08:43 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:08:43 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:08:43 INFO - 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 13:08:43 INFO - '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'} 13:08:43 INFO - Collecting requests==2.8.1 13:08:44 INFO - Using cached requests-2.8.1-py2.py3-none-any.whl 13:08:44 INFO - Installing collected packages: requests 13:08:45 INFO - Successfully installed requests-2.8.1 13:08:46 INFO - c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\lib\site-packages\pip-8.1.2-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.org/en/latest/security.html#snimissingwarning. 13:08:46 INFO - SNIMissingWarning 13:08:46 INFO - c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\lib\site-packages\pip-8.1.2-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.org/en/latest/security.html#insecureplatformwarning. 13:08:46 INFO - InsecurePlatformWarning 13:08:46 INFO - c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\lib\site-packages\pip-8.1.2-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.org/en/latest/security.html#insecureplatformwarning. 13:08:46 INFO - InsecurePlatformWarning 13:08:46 INFO - Return code: 0 13:08:46 INFO - Installing PyHawk-with-a-single-extra-commit==0.1.5 into virtualenv c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv 13:08:46 INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\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 0x02218C58>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022EC278>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02441D40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0260B8F8>, '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 0x02319928>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0234B4B8>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build', 'env': {'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'USERNAME': 'cltbld', 'COMPUTERNAME': 'B-2008-SPOT-106', 'SYSTEMDRIVE': 'C:', 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 'USERDOMAIN': 'B-2008-SPOT-106', 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 'MOZ_AUTOMATION': '1', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'HOSTTYPE': 'i686', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel', 'CVS_RSH': 'ssh', 'LOGNAME': 'cltbld', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'SYSTEMROOT': 'C:\\Windows', 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'MSYSTEM': 'MINGW32', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'MAKE_MODE': 'unix', 'TERM': 'cygwin', 'SHELL': 'C:/mozilla-build/msys/bin/sh', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 'SHLVL': '1', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_ARCHITECTURE': 'x86', 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'EDITOR': 'emacs.exe', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'OSTYPE': 'msys', 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'SSH_AGENT_PID': '3760', 'HOME': 'c:/Users/cltbld', 'PROGRAMW6432': 'C:\\Program Files', 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 'TOOLTOOL_HOME': '/c/builds', 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 'PROMPT': '$P$G', 'WINDOWS_TRACING_FLAGS': '3', 'PROCESSOR_REVISION': '3f02', 'PROGRAMDATA': 'C:\\ProgramData', 'LOG': '"c:\\runner\\buildbot-startup.log"', 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656', 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\hg;c:\\mozilla-build\\buildbotve\\Scripts;c:\\ProgramData\\chocolatey\\bin;.;c:\\opt\\runner;c:\\mozilla-build\\buildbotve;c:\\mozilla-build\\python27;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\msys\\local\\bin;.;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\moztools-x64\\bin;c:\\mozilla-build\\vim\\vim72', 'IDLEIZER_HALT_ON_IDLE': 'true', 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 'TINDERBOX_OUTPUT': '1', 'LOGONSERVER': '\\\\B-2008-SPOT-106', 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/l-w64-000000000000000000000000/signing_cache -t /c/builds/moz2_slave/l-w64-000000000000000000000000/token -n /c/builds/moz2_slave/l-w64-000000000000000000000000/nonce -c /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'HOMEPATH': '\\', 'MOZILLABUILD': 'C:\\mozilla-build', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'FP_NO_HOST_CHECK': 'NO', 'WINDIR': 'C:\\Windows', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'HOMEDRIVE': 'C:', 'OS_VERSION': '2008', 'MOZBUILDDIR': 'C:\\mozilla-build', 'OLDPWD': 'c:/Users/cltbld', 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'c:/Users/cltbld', 'PROCESSOR_LEVEL': '6', 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'USERPROFILE': 'C:\\Users\\cltbld'}}, attempt #1 13:08:46 INFO - Running command: ['c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'PyHawk-with-a-single-extra-commit==0.1.5'] in c:\builds\moz2_slave\l-w64-000000000000000000000000\build 13:08:46 INFO - Copy/paste: c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Scripts\pip install --timeout 120 PyHawk-with-a-single-extra-commit==0.1.5 13:08:46 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:08:46 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:08:46 INFO - 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 13:08:46 INFO - 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 13:08:46 INFO - 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 13:08:46 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 13:08:46 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 13:08:46 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 13:08:46 INFO - 'COMPUTERNAME': 'B-2008-SPOT-106', 13:08:46 INFO - 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 13:08:46 INFO - 'CVS_RSH': 'ssh', 13:08:46 INFO - 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 13:08:46 INFO - 'EDITOR': 'emacs.exe', 13:08:46 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:08:46 INFO - 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 13:08:46 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 13:08:46 INFO - 'HOME': 'c:/Users/cltbld', 13:08:46 INFO - 'HOMEDRIVE': 'C:', 13:08:46 INFO - 'HOMEPATH': '\\', 13:08:46 INFO - 'HOSTTYPE': 'i686', 13:08:46 INFO - 'IDLEIZER_HALT_ON_IDLE': 'true', 13:08:46 INFO - 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 13:08:46 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:08:46 INFO - 'LOG': '"c:\\runner\\buildbot-startup.log"', 13:08:46 INFO - 'LOGNAME': 'cltbld', 13:08:46 INFO - 'LOGONSERVER': '\\\\B-2008-SPOT-106', 13:08:46 INFO - 'MACHTYPE': 'i686-pc-msys', 13:08:46 INFO - 'MAKE_MODE': 'unix', 13:08:46 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build', 13:08:46 INFO - 'MOZILLABUILD': 'C:\\mozilla-build', 13:08:46 INFO - 'MOZ_AUTOMATION': '1', 13:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:46 INFO - 'MOZ_OBJDIR': 'obj-firefox', 13:08:46 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 13:08:46 INFO - 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/l-w64-000000000000000000000000/signing_cache -t /c/builds/moz2_slave/l-w64-000000000000000000000000/token -n /c/builds/moz2_slave/l-w64-000000000000000000000000/nonce -c /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 13:08:46 INFO - 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 13:08:46 INFO - 'MSYSTEM': 'MINGW32', 13:08:46 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:08:46 INFO - 'OLDPWD': 'c:/Users/cltbld', 13:08:46 INFO - 'OS': 'Windows_NT', 13:08:46 INFO - 'OSTYPE': 'msys', 13:08:46 INFO - 'OS_VERSION': '2008', 13:08:46 INFO - 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\hg;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:08:46 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:08:46 INFO - 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 13:08:46 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:08:46 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 13:08:46 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel', 13:08:46 INFO - 'PROCESSOR_LEVEL': '6', 13:08:46 INFO - 'PROCESSOR_REVISION': '3f02', 13:08:46 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:08:46 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 13:08:46 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 13:08:46 INFO - 'PROGRAMW6432': 'C:\\Program Files', 13:08:46 INFO - 'PROMPT': '$P$G', 13:08:46 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\buildprops.json', 13:08:46 INFO - 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 13:08:46 INFO - 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 13:08:46 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:08:46 INFO - 'PWD': 'c:/Users/cltbld', 13:08:46 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:08:46 INFO - 'SHELL': 'C:/mozilla-build/msys/bin/sh', 13:08:46 INFO - 'SHLVL': '1', 13:08:46 INFO - 'SSH_AGENT_PID': '3760', 13:08:46 INFO - 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656', 13:08:46 INFO - 'SYSTEMDRIVE': 'C:', 13:08:46 INFO - 'SYSTEMROOT': 'C:\\Windows', 13:08:46 INFO - 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 13:08:46 INFO - 'TERM': 'cygwin', 13:08:46 INFO - 'TINDERBOX_OUTPUT': '1', 13:08:46 INFO - 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 13:08:46 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 13:08:46 INFO - 'TOOLTOOL_HOME': '/c/builds', 13:08:46 INFO - 'USERDOMAIN': 'B-2008-SPOT-106', 13:08:46 INFO - 'USERNAME': 'cltbld', 13:08:46 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:08:46 INFO - 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 13:08:46 INFO - 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 13:08:46 INFO - 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 13:08:46 INFO - 'WINDIR': 'C:\\Windows', 13:08:46 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:08:46 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:08:46 INFO - 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 13:08:46 INFO - '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'} 13:08:47 INFO - Collecting PyHawk-with-a-single-extra-commit==0.1.5 13:08:47 INFO - Using cached PyHawk-with-a-single-extra-commit-0.1.5.tar.gz 13:08:47 INFO - Installing collected packages: PyHawk-with-a-single-extra-commit 13:08:47 INFO - Running setup.py install for PyHawk-with-a-single-extra-commit: started 13:08:48 INFO - Running setup.py install for PyHawk-with-a-single-extra-commit: finished with status 'done' 13:08:48 INFO - Successfully installed PyHawk-with-a-single-extra-commit-0.1.5 13:08:48 INFO - c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\lib\site-packages\pip-8.1.2-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.org/en/latest/security.html#snimissingwarning. 13:08:48 INFO - SNIMissingWarning 13:08:48 INFO - c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\lib\site-packages\pip-8.1.2-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.org/en/latest/security.html#insecureplatformwarning. 13:08:48 INFO - InsecurePlatformWarning 13:08:48 INFO - Return code: 0 13:08:48 INFO - Installing taskcluster==0.0.26 into virtualenv c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv 13:08:48 INFO - retry: Calling run_command with args: [['c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\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 0x02218C58>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022EC278>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02441D40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0260B8F8>, '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 0x02319928>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0234B4B8>, 'level': 'critical'}], 'cwd': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build', 'env': {'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 'USERNAME': 'cltbld', 'COMPUTERNAME': 'B-2008-SPOT-106', 'SYSTEMDRIVE': 'C:', 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 'USERDOMAIN': 'B-2008-SPOT-106', 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 'MOZ_AUTOMATION': '1', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 'HOSTTYPE': 'i686', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel', 'CVS_RSH': 'ssh', 'LOGNAME': 'cltbld', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 'MOZ_OBJDIR': 'obj-firefox', 'SYSTEMROOT': 'C:\\Windows', 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'MSYSTEM': 'MINGW32', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'MAKE_MODE': 'unix', 'TERM': 'cygwin', 'SHELL': 'C:/mozilla-build/msys/bin/sh', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 'SHLVL': '1', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_ARCHITECTURE': 'x86', 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'EDITOR': 'emacs.exe', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'OSTYPE': 'msys', 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'SSH_AGENT_PID': '3760', 'HOME': 'c:/Users/cltbld', 'PROGRAMW6432': 'C:\\Program Files', 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 'TOOLTOOL_HOME': '/c/builds', 'RUNNER_CONFIG_CMD': 'C:\\opt\\runner\\Scripts\\python2.7.exe C:\\opt\\runner\\Scripts\\runner-script.py -c c:\\opt\\runner\\runner.cfg', 'PROMPT': '$P$G', 'WINDOWS_TRACING_FLAGS': '3', 'PROCESSOR_REVISION': '3f02', 'PROGRAMDATA': 'C:\\ProgramData', 'LOG': '"c:\\runner\\buildbot-startup.log"', 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656', 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\hg;c:\\mozilla-build\\buildbotve\\Scripts;c:\\ProgramData\\chocolatey\\bin;.;c:\\opt\\runner;c:\\mozilla-build\\buildbotve;c:\\mozilla-build\\python27;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\msys\\local\\bin;.;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\moztools-x64\\bin;c:\\mozilla-build\\vim\\vim72', 'IDLEIZER_HALT_ON_IDLE': 'true', 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 'TINDERBOX_OUTPUT': '1', 'LOGONSERVER': '\\\\B-2008-SPOT-106', 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/l-w64-000000000000000000000000/signing_cache -t /c/builds/moz2_slave/l-w64-000000000000000000000000/token -n /c/builds/moz2_slave/l-w64-000000000000000000000000/nonce -c /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'HOMEPATH': '\\', 'MOZILLABUILD': 'C:\\mozilla-build', '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python', 'FP_NO_HOST_CHECK': 'NO', 'WINDIR': 'C:\\Windows', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 'HOMEDRIVE': 'C:', 'OS_VERSION': '2008', 'MOZBUILDDIR': 'C:\\mozilla-build', 'OLDPWD': 'c:/Users/cltbld', 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'c:/Users/cltbld', 'PROCESSOR_LEVEL': '6', 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'MACHTYPE': 'i686-pc-msys', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'USERPROFILE': 'C:\\Users\\cltbld'}}, attempt #1 13:08:48 INFO - Running command: ['c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', 'taskcluster==0.0.26'] in c:\builds\moz2_slave\l-w64-000000000000000000000000\build 13:08:48 INFO - Copy/paste: c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Scripts\pip install --timeout 120 taskcluster==0.0.26 13:08:48 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:08:48 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:08:48 INFO - 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 13:08:48 INFO - 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 13:08:48 INFO - 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 13:08:48 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 13:08:48 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 13:08:48 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 13:08:48 INFO - 'COMPUTERNAME': 'B-2008-SPOT-106', 13:08:48 INFO - 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 13:08:48 INFO - 'CVS_RSH': 'ssh', 13:08:48 INFO - 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 13:08:48 INFO - 'EDITOR': 'emacs.exe', 13:08:48 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:08:48 INFO - 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 13:08:48 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 13:08:48 INFO - 'HOME': 'c:/Users/cltbld', 13:08:48 INFO - 'HOMEDRIVE': 'C:', 13:08:48 INFO - 'HOMEPATH': '\\', 13:08:48 INFO - 'HOSTTYPE': 'i686', 13:08:48 INFO - 'IDLEIZER_HALT_ON_IDLE': 'true', 13:08:48 INFO - 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 13:08:48 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:08:48 INFO - 'LOG': '"c:\\runner\\buildbot-startup.log"', 13:08:48 INFO - 'LOGNAME': 'cltbld', 13:08:48 INFO - 'LOGONSERVER': '\\\\B-2008-SPOT-106', 13:08:48 INFO - 'MACHTYPE': 'i686-pc-msys', 13:08:48 INFO - 'MAKE_MODE': 'unix', 13:08:48 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build', 13:08:48 INFO - 'MOZILLABUILD': 'C:\\mozilla-build', 13:08:48 INFO - 'MOZ_AUTOMATION': '1', 13:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:48 INFO - 'MOZ_OBJDIR': 'obj-firefox', 13:08:48 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 13:08:48 INFO - 'MOZ_SIGN_CMD': 'python /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/signtool.py --cachedir /c/builds/moz2_slave/l-w64-000000000000000000000000/signing_cache -t /c/builds/moz2_slave/l-w64-000000000000000000000000/token -n /c/builds/moz2_slave/l-w64-000000000000000000000000/nonce -c /c/builds/moz2_slave/l-w64-000000000000000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 13:08:48 INFO - 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 13:08:48 INFO - 'MSYSTEM': 'MINGW32', 13:08:48 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:08:48 INFO - 'OLDPWD': 'c:/Users/cltbld', 13:08:48 INFO - 'OS': 'Windows_NT', 13:08:48 INFO - 'OSTYPE': 'msys', 13:08:48 INFO - 'OS_VERSION': '2008', 13:08:48 INFO - 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\hg;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:08:48 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:08:48 INFO - 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 13:08:48 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:08:48 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 13:08:48 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel', 13:08:48 INFO - 'PROCESSOR_LEVEL': '6', 13:08:48 INFO - 'PROCESSOR_REVISION': '3f02', 13:08:48 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:08:48 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 13:08:48 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 13:08:48 INFO - 'PROGRAMW6432': 'C:\\Program Files', 13:08:48 INFO - 'PROMPT': '$P$G', 13:08:48 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\buildprops.json', 13:08:48 INFO - 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 13:08:48 INFO - 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 13:08:48 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:08:48 INFO - 'PWD': 'c:/Users/cltbld', 13:08:48 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:08:48 INFO - 'SHELL': 'C:/mozilla-build/msys/bin/sh', 13:08:48 INFO - 'SHLVL': '1', 13:08:48 INFO - 'SSH_AGENT_PID': '3760', 13:08:48 INFO - 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656', 13:08:48 INFO - 'SYSTEMDRIVE': 'C:', 13:08:48 INFO - 'SYSTEMROOT': 'C:\\Windows', 13:08:48 INFO - 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 13:08:48 INFO - 'TERM': 'cygwin', 13:08:48 INFO - 'TINDERBOX_OUTPUT': '1', 13:08:48 INFO - 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 13:08:48 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 13:08:48 INFO - 'TOOLTOOL_HOME': '/c/builds', 13:08:48 INFO - 'USERDOMAIN': 'B-2008-SPOT-106', 13:08:48 INFO - 'USERNAME': 'cltbld', 13:08:48 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:08:48 INFO - 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 13:08:48 INFO - 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 13:08:48 INFO - 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 13:08:48 INFO - 'WINDIR': 'C:\\Windows', 13:08:48 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:08:48 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:08:48 INFO - 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 13:08:48 INFO - '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'} 13:08:48 INFO - Collecting taskcluster==0.0.26 13:08:49 INFO - Using cached taskcluster-0.0.26.tar.gz 13:08:49 INFO - Collecting requests<=2.7.0,>=2.4.3 (from taskcluster==0.0.26) 13:08:49 INFO - Using cached requests-2.7.0-py2.py3-none-any.whl 13:08:50 INFO - Requirement already satisfied (use --upgrade to upgrade): PyHawk_with_a_single_extra_commit==0.1.5 in .\venv\lib\site-packages (from taskcluster==0.0.26) 13:08:50 INFO - Collecting slugid (from taskcluster==0.0.26) 13:08:50 INFO - Using cached slugid-1.0.7.tar.gz 13:08:50 INFO - Installing collected packages: requests, slugid, taskcluster 13:08:50 INFO - Found existing installation: requests 2.8.1 13:08:50 INFO - Uninstalling requests-2.8.1: 13:08:51 INFO - Successfully uninstalled requests-2.8.1 13:08:53 INFO - Running setup.py install for slugid: started 13:08:53 INFO - Running setup.py install for slugid: finished with status 'done' 13:08:53 INFO - Running setup.py install for taskcluster: started 13:08:54 INFO - Running setup.py install for taskcluster: finished with status 'done' 13:08:54 INFO - Successfully installed requests-2.7.0 slugid-1.0.7 taskcluster-0.0.26 13:08:54 INFO - c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\lib\site-packages\pip-8.1.2-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.org/en/latest/security.html#snimissingwarning. 13:08:54 INFO - SNIMissingWarning 13:08:54 INFO - c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\lib\site-packages\pip-8.1.2-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.org/en/latest/security.html#insecureplatformwarning. 13:08:54 INFO - InsecurePlatformWarning 13:08:54 INFO - Return code: 0 13:08:54 INFO - Done creating virtualenv c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv. 13:08:54 INFO - Getting output from command: ['c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\venv\\Scripts\\pip', 'freeze'] 13:08:54 INFO - Copy/paste: c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Scripts\pip freeze 13:08:55 INFO - Reading from file tmpfile_stdout 13:08:55 INFO - Using _rmtree_windows ... 13:08:55 INFO - Using _rmtree_windows ... 13:08:55 INFO - Current package versions: 13:08:55 INFO - PyHawk-with-a-single-extra-commit == 0.1.5 13:08:55 INFO - requests == 2.7.0 13:08:55 INFO - slugid == 1.0.7 13:08:55 INFO - taskcluster == 0.0.26 13:08:55 INFO - Running pre-run listener: influxdb_recording_init 13:08:55 INFO - build_resources.json path: c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src/obj-firefox/.mozbuild/build_resources.json 13:08:55 INFO - rmtree: c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src/obj-firefox/.mozbuild/build_resources.json 13:08:55 INFO - Using _rmtree_windows ... 13:08:55 INFO - retry: Calling _rmtree_windows with args: ('c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\src/obj-firefox/.mozbuild/build_resources.json',), kwargs: {}, attempt #1 13:08:55 INFO - Getting output from command: ['c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\venv\\Scripts\\python', '-c', 'from distutils.sysconfig import get_python_lib; print(get_python_lib())'] 13:08:55 INFO - Copy/paste: c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Scripts\python -c "from distutils.sysconfig import get_python_lib; print(get_python_lib())" 13:08:55 INFO - Reading from file tmpfile_stdout 13:08:55 INFO - Output received: 13:08:55 INFO - c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Lib\site-packages 13:08:55 INFO - Using _rmtree_windows ... 13:08:55 INFO - Using _rmtree_windows ... 13:08:55 INFO - Dumping config to c:\builds\moz2_slave\l-w64-000000000000000000000000\logs\localconfig.json. 13:08:55 INFO - {'app_ini_path': '%(obj_dir)s/dist/bin/application.ini', 13:08:55 INFO - 'append_to_log': False, 13:08:55 INFO - 'balrog_credentials_file': 'oauth.txt', 13:08:55 INFO - 'balrog_servers': ({'balrog_api_root': 'https://aus4-admin.mozilla.org/api', 13:08:55 INFO - 'balrog_usernames': {'Fennec': 'ffxbld', 13:08:55 INFO - 'b2g': 'b2gbld', 13:08:55 INFO - 'firefox': 'ffxbld', 13:08:55 INFO - 'graphene': 'ffxbld', 13:08:55 INFO - 'horizon': 'ffxbld', 13:08:55 INFO - 'mobile': 'ffxbld', 13:08:55 INFO - 'thunderbird': 'tbirdbld'}, 13:08:55 INFO - 'ignore_failures': False, 13:08:55 INFO - 'url_replacements': (('http://archive.mozilla.org/pub', 13:08:55 INFO - 'http://download.cdn.mozilla.net/pub'),)},), 13:08:55 INFO - 'base_name': 'WINNT_6.1_x86-64_%(branch)s', 13:08:55 INFO - 'base_work_dir': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000', 13:08:55 INFO - 'branch': 'larch', 13:08:55 INFO - 'build_pool': 'production', 13:08:55 INFO - 'build_resources_path': '%(abs_src_dir)s/obj-firefox/.mozbuild/build_resources.json', 13:08:55 INFO - 'buildbot_json_path': 'buildprops.json', 13:08:55 INFO - 'check_test_env': {'MINIDUMP_SAVE_PATH': '%(base_work_dir)s/minidumps', 13:08:55 INFO - 'MINIDUMP_STACKWALK': '%(abs_tools_dir)s/breakpad/win64/minidump_stackwalk.exe'}, 13:08:55 INFO - 'clobberer_url': 'https://api.pub.build.mozilla.org/clobberer/lastclobber', 13:08:55 INFO - 'clone_by_revision': False, 13:08:55 INFO - 'clone_with_purge': False, 13:08:55 INFO - 'config_files': ('builds/releng_base_windows_64_builds.py', 13:08:55 INFO - 'balrog/production.py', 13:08:55 INFO - 'builds/branch_specifics.py', 13:08:55 INFO - 'builds/build_pool_specifics.py'), 13:08:55 INFO - 'debug_build': False, 13:08:55 INFO - 'default_actions': ('clobber', 13:08:55 INFO - 'clone-tools', 13:08:55 INFO - 'checkout-sources', 13:08:55 INFO - 'build', 13:08:55 INFO - 'upload-files', 13:08:55 INFO - 'sendchange', 13:08:55 INFO - 'check-test', 13:08:55 INFO - 'generate-build-stats', 13:08:55 INFO - 'update'), 13:08:55 INFO - 'enable_ccache': False, 13:08:55 INFO - 'enable_count_ctors': False, 13:08:55 INFO - 'enable_pymake': True, 13:08:55 INFO - 'enable_signing': True, 13:08:55 INFO - 'enable_talos_sendchange': True, 13:08:55 INFO - 'enable_unittest_sendchange': True, 13:08:55 INFO - 'env': {'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 13:08:55 INFO - 'MOZ_AUTOMATION': '1', 13:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:55 INFO - 'MOZ_OBJDIR': 'obj-firefox', 13:08:55 INFO - 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\hg;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:08:55 INFO - 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 13:08:55 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\buildprops.json', 13:08:55 INFO - 'TINDERBOX_OUTPUT': '1', 13:08:55 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 13:08:55 INFO - 'TOOLTOOL_HOME': '/c/builds'}, 13:08:55 INFO - 'exes': {'buildbot': ('c:\\mozilla-build\\python27\\python.exe', 13:08:55 INFO - 'c:\\mozilla-build\\buildbotve\\scripts\\buildbot'), 13:08:55 INFO - 'make': ('c:\\mozilla-build\\python27\\python.exe', 13:08:55 INFO - 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\src\\build\\pymake\\make.py'), 13:08:55 INFO - 'python2.7': 'c:\\mozilla-build\\python27\\python.exe', 13:08:55 INFO - 'virtualenv': ('c:\\mozilla-build\\python27\\python.exe', 13:08:55 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 13:08:55 INFO - 'graph_selector': '/server/collect.cgi', 13:08:55 INFO - 'graph_server': 'graphs.mozilla.org', 13:08:55 INFO - 'include_post_upload_builddir': False, 13:08:55 INFO - 'influx_credentials_file': 'oauth.txt', 13:08:55 INFO - 'is_automation': True, 13:08:55 INFO - 'latest_mar_dir': '/pub/mozilla.org/firefox/nightly/latest-%(branch)s', 13:08:55 INFO - 'log_level': 'info', 13:08:55 INFO - 'log_to_console': True, 13:08:55 INFO - 'max_build_output_timeout': 4800, 13:08:55 INFO - 'nightly_build': False, 13:08:55 INFO - 'nightly_promotion_branches': ('mozilla-central', 'mozilla-aurora'), 13:08:55 INFO - 'objdir': 'obj-firefox', 13:08:55 INFO - 'old_packages': ('%(objdir)s/dist/firefox-*', 13:08:55 INFO - '%(objdir)s/dist/fennec*', 13:08:55 INFO - '%(objdir)s/dist/seamonkey*', 13:08:55 INFO - '%(objdir)s/dist/thunderbird*', 13:08:55 INFO - '%(objdir)s/dist/install/sea/*.exe'), 13:08:55 INFO - 'opt_config_files': (), 13:08:55 INFO - 'periodic_clobber': 168, 13:08:55 INFO - 'pgo_build': False, 13:08:55 INFO - 'pgo_platforms': ('linux', 'linux64', 'win32', 'win64'), 13:08:55 INFO - 'platform': 'win64', 13:08:55 INFO - 'platform_supports_post_upload_to_latest': True, 13:08:55 INFO - 'publish_nightly_en_US_routes': True, 13:08:55 INFO - 'release_to_try_builds': False, 13:08:55 INFO - 'repo_base': 'https://hg.mozilla.org', 13:08:55 INFO - 'scm_level': 1, 13:08:55 INFO - 'sendchange_masters': ('buildbot-master81.build.mozilla.org:9301',), 13:08:55 INFO - 'src_mozconfig': 'browser/config/mozconfigs/win64/nightly', 13:08:55 INFO - 'stage_platform': 'win64', 13:08:55 INFO - 'stage_product': 'firefox', 13:08:55 INFO - 'stage_server': 'upload.ffxbld.productdelivery.prod.mozaws.net', 13:08:55 INFO - 'stage_ssh_key': 'ffxbld_rsa', 13:08:55 INFO - 'stage_username': 'ffxbld', 13:08:55 INFO - 'taskcluster_credentials_file': 'oauth.txt', 13:08:55 INFO - 'taskcluster_index': 'index', 13:08:55 INFO - 'tinderbox_build_dir': None, 13:08:55 INFO - 'to_tinderbox_dated': True, 13:08:55 INFO - 'tools_repo': 'https://hg.mozilla.org/build/tools', 13:08:55 INFO - 'tooltool_bootstrap': 'setup.sh', 13:08:55 INFO - 'tooltool_manifest_src': 'browser/config/tooltool-manifests/win64/releng.manifest', 13:08:55 INFO - 'tooltool_script': ('c:\\mozilla-build\\python27\\python.exe', 13:08:55 INFO - 'C:/mozilla-build/tooltool.py'), 13:08:55 INFO - 'tooltool_url': 'https://api.pub.build.mozilla.org/tooltool/', 13:08:55 INFO - 'upload_env': {'UPLOAD_HOST': '%(stage_server)s', 13:08:55 INFO - 'UPLOAD_SSH_KEY': '/c/Users/cltbld/.ssh/%(stage_ssh_key)s', 13:08:55 INFO - 'UPLOAD_TO_TEMP': '1', 13:08:55 INFO - 'UPLOAD_USER': '%(stage_username)s'}, 13:08:55 INFO - 'use_clobberer': True, 13:08:55 INFO - 'vcs_share_base': 'C:/builds/hg-shared', 13:08:55 INFO - 'virtualenv_modules': ('requests==2.8.1', 13:08:55 INFO - 'PyHawk-with-a-single-extra-commit==0.1.5', 13:08:55 INFO - 'taskcluster==0.0.26'), 13:08:55 INFO - 'virtualenv_path': 'venv', 13:08:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:08:55 INFO - 'who': '', 13:08:55 INFO - 'work_dir': 'build'} 13:08:55 INFO - [mozharness: 2016-10-11 20:08:55.358000Z] Skipping get-secrets step. 13:08:55 INFO - [mozharness: 2016-10-11 20:08:55.358000Z] Running clobber step. 13:08:55 INFO - Running pre-action listener: influxdb_recording_pre_action 13:08:55 INFO - Running main action method: clobber 13:08:55 INFO - retry: Calling run_command with args: [['python', 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\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'larch', u'WINNT 6.1 x86-64 larch build', 'l-w64-000000000000000000000000', u'b-2008-spot-106', u'http://buildbot-master73.bb.releng.usw2.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 13:08:55 INFO - Running command: ['python', 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\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'larch', u'WINNT 6.1 x86-64 larch build', 'l-w64-000000000000000000000000', u'b-2008-spot-106', u'http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/'] in c:\builds\moz2_slave 13:08:55 INFO - Copy/paste: python c:\builds\moz2_slave\l-w64-000000000000000000000000\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 larch "WINNT 6.1 x86-64 larch build" l-w64-000000000000000000000000 b-2008-spot-106 http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/ 13:08:55 INFO - Checking clobber URL: https://api.pub.build.mozilla.org/clobberer/lastclobber?master=http%3A%2F%2Fbuildbot-master73.bb.releng.usw2.mozilla.com%3A8001%2F&slave=b-2008-spot-106&builddir=l-w64-000000000000000000000000&branch=larch&buildername=WINNT+6.1+x86-64+larch+build 13:08:55 INFO - l-w64-000000000000000000000000:Our last clobber date: None 13:08:55 INFO - l-w64-000000000000000000000000:Server clobber date: None 13:08:55 INFO - TinderboxPrint: purged clobber 13:08:55 INFO - Return code: 0 13:08:55 INFO - Running post-action listener: influxdb_recording_post_action 13:08:55 INFO - Starting new HTTPS connection (1): goldiewilson-onepointtwentyone-1.c.influxdb.com c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Lib\site-packages\requests\packages\urllib3\util\ssl_.py:90: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. For more information, see https://urllib3.readthedocs.org/en/latest/security.html#insecureplatformwarning. InsecurePlatformWarning 13:08:56 INFO - [mozharness: 2016-10-11 20:08:56.239000Z] Finished clobber step (success) 13:08:56 INFO - [mozharness: 2016-10-11 20:08:56.239000Z] Running clone-tools step. 13:08:56 INFO - Running pre-action listener: influxdb_recording_pre_action 13:08:56 INFO - Running main action method: clone_tools 13:08:56 INFO - retry: Calling _get_revision with args: (, 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\tools'), kwargs: {}, attempt #1 13:08:56 WARNING - did not specify revision or branch; assuming "default" 13:08:56 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version'] 13:08:56 INFO - Copy/paste: hg --config ui.merge=internal:merge --version 13:09:01 INFO - Mercurial Distributed SCM (version 3.9.1) 13:09:01 INFO - (see https://mercurial-scm.org for more information) 13:09:01 INFO - Copyright (C) 2005-2016 Matt Mackall and others 13:09:01 INFO - This is free software; see the source for copying conditions. There is NO 13:09:01 INFO - warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. 13:09:01 INFO - Return code: 0 13:09:01 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall'] 13:09:01 INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall 13:09:02 INFO - checking encoding (cp1252)... 13:09:02 INFO - checking Python executable (c:\mozilla-build\hg\hg.exe) 13:09:02 INFO - checking Python version (2.7.12) 13:09:02 INFO - checking Python lib (c:\mozilla-build\hg\lib\library.zip)... 13:09:02 INFO - checking Mercurial version (3.9.1) 13:09:02 INFO - checking Mercurial custom build () 13:09:02 INFO - checking module policy (c) 13:09:02 INFO - checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)... 13:09:02 INFO - checking templates (c:\mozilla-build\hg\templates)... 13:09:02 INFO - checking default template (c:\mozilla-build\hg\templates\map-cmdline.default) 13:09:02 INFO - checking commit editor... (notepad) 13:09:02 INFO - checking username (Mozilla Release Engineering ) 13:09:02 INFO - no problems detected 13:09:02 INFO - Return code: 0 13:09:02 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/build/tools', 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\tools', '--sharebase', 'C:/builds/hg-shared', '--branch', 'default'] 13:09:02 INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\l-w64-000000000000000000000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/build/tools c:\builds\moz2_slave\l-w64-000000000000000000000000\build\tools --sharebase C:/builds/hg-shared --branch default 13:09:04 INFO - ensuring https://hg.mozilla.org/build/tools@default is available at c:\builds\moz2_slave\l-w64-000000000000000000000000\build\tools 13:09:04 INFO - (sharing from existing pooled repository 7ae7fb134bf7aec6ec96a062ff47a69053dd2973) 13:09:04 INFO - searching for changes 13:09:04 INFO - no changes found 13:09:04 INFO - (pulling to obtain default) 13:09:04 INFO - (remote resolved default to 2635bfe421b7af3a599c22b0b75fbf423f6d300d; result is not deterministic) 13:09:04 INFO - (revision already present locally; not pulling) 13:09:34 INFO - 13:09:34 INFO - updating [============> ] 300/1144 18s 13:09:34 INFO - updating [=================> ] 400/1144 17s 13:09:34 INFO - updating [======================> ] 500/1144 14s 13:09:34 INFO - updating [==========================> ] 600/1144 12s 13:09:34 INFO - updating [===============================> ] 700/1144 11s 13:09:34 INFO - updating [====================================> ] 800/1144 08s 13:09:34 INFO - updating [========================================> ] 900/1144 06s 13:09:34 INFO - updating [=============================================> ] 1000/1144 04s 13:09:34 INFO - updating [=================================================> ] 1100/1144 02s 13:09:34 INFO - updating [====================================================>] 1144/1144 01s 13:09:34 INFO - 13:09:34 INFO - 1144 files updated, 0 files merged, 0 files removed, 0 files unresolved 13:09:34 INFO - updated to 2635bfe421b7af3a599c22b0b75fbf423f6d300d 13:09:34 INFO - Return code: 0 13:09:34 INFO - Running post-action listener: influxdb_recording_post_action 13:09:34 INFO - Resetting dropped connection: goldiewilson-onepointtwentyone-1.c.influxdb.com c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Lib\site-packages\requests\packages\urllib3\util\ssl_.py:90: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. For more information, see https://urllib3.readthedocs.org/en/latest/security.html#insecureplatformwarning. InsecurePlatformWarning 13:09:34 INFO - [mozharness: 2016-10-11 20:09:34.372000Z] Finished clone-tools step (success) 13:09:34 INFO - [mozharness: 2016-10-11 20:09:34.372000Z] Running checkout-sources step. 13:09:34 INFO - Running pre-action listener: influxdb_recording_pre_action 13:09:34 INFO - Running main action method: checkout_sources 13:09:34 INFO - retry: Calling _get_revision with args: (, 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\src'), kwargs: {}, attempt #1 13:09:34 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version'] 13:09:34 INFO - Copy/paste: hg --config ui.merge=internal:merge --version 13:09:34 INFO - Mercurial Distributed SCM (version 3.9.1) 13:09:34 INFO - (see https://mercurial-scm.org for more information) 13:09:34 INFO - Copyright (C) 2005-2016 Matt Mackall and others 13:09:34 INFO - This is free software; see the source for copying conditions. There is NO 13:09:34 INFO - warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. 13:09:34 INFO - Return code: 0 13:09:34 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall'] 13:09:34 INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall 13:09:34 INFO - checking encoding (cp1252)... 13:09:34 INFO - checking Python executable (c:\mozilla-build\hg\hg.exe) 13:09:34 INFO - checking Python version (2.7.12) 13:09:34 INFO - checking Python lib (c:\mozilla-build\hg\lib\library.zip)... 13:09:34 INFO - checking Mercurial version (3.9.1) 13:09:34 INFO - checking Mercurial custom build () 13:09:34 INFO - checking module policy (c) 13:09:34 INFO - checking installed modules (c:\mozilla-build\hg\lib\library.zip\mercurial)... 13:09:34 INFO - checking templates (c:\mozilla-build\hg\templates)... 13:09:34 INFO - checking default template (c:\mozilla-build\hg\templates\map-cmdline.default) 13:09:34 INFO - checking commit editor... (notepad) 13:09:34 INFO - checking username (Mozilla Release Engineering ) 13:09:34 INFO - no problems detected 13:09:34 INFO - Return code: 0 13:09:34 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\scripts\\external_tools\\robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/projects/larch', 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\src', '--sharebase', 'C:/builds/hg-shared', '--revision', '15a5f3920481be2c6cacf4938eedc28c77d37077'] 13:09:34 INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=c:\builds\moz2_slave\l-w64-000000000000000000000000\scripts\external_tools\robustcheckout.py robustcheckout https://hg.mozilla.org/projects/larch c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src --sharebase C:/builds/hg-shared --revision 15a5f3920481be2c6cacf4938eedc28c77d37077 13:11:25 INFO - 13:11:25 INFO - searching [ <=> ] 3 13:11:25 INFO - searching [ <=> ] 6 13:11:25 INFO - 13:11:25 INFO - 13:11:25 INFO - manifests [=> ] 2/45 13:11:25 INFO - manifests [===========================> ] 23/45 03s 13:11:25 INFO - manifests [==========================================> ] 35/45 02s 13:11:25 INFO - 13:11:25 INFO - 13:11:25 INFO - files [ ] 23/6032 9m31s 13:11:25 INFO - files [ ] 38/6032 8m28s 13:11:25 INFO - 13:11:25 INFO - ensuring https://hg.mozilla.org/projects/larch@15a5f3920481be2c6cacf4938eedc28c77d37077 is available at c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src 13:11:25 INFO - (sharing from existing pooled repository 8ba995b74e18334ab3707f27e9eb8f4e37ba3d29) 13:11:25 INFO - searching for changes 13:11:25 INFO - adding changesets 13:11:25 INFO - adding manifests 13:11:25 INFO - adding file changes 13:11:25 INFO - added 45 changesets with 161 changes to 53 files (+2 heads) 13:30:53 INFO - 13:30:53 INFO - updating [ ] 100/148481 13:30:53 INFO - updating [ ] 200/148481 1h20m 13:30:53 INFO - updating [ ] 300/148481 1h24m 13:30:53 INFO - updating [ ] 400/148481 1h24m 13:30:53 INFO - updating [ ] 500/148481 1h28m 13:30:53 INFO - updating [ ] 600/148481 1h27m 13:30:53 INFO - updating [ ] 700/148481 1h28m 13:30:53 INFO - updating [ ] 800/148481 1h25m 13:30:53 INFO - updating [ ] 900/148481 1h26m 13:30:53 INFO - updating [ ] 1000/148481 1h25m 13:30:53 INFO - updating [ ] 1100/148481 1h26m 13:30:53 INFO - updating [ ] 1200/148481 1h27m 13:30:53 INFO - updating [ ] 1300/148481 1h26m 13:30:53 INFO - updating [ ] 1400/148481 1h23m 13:30:53 INFO - updating [ ] 1500/148481 1h23m 13:30:53 INFO - updating [ ] 1600/148481 1h21m 13:30:53 INFO - updating [ ] 1700/148481 1h19m 13:30:53 INFO - updating [ ] 1800/148481 1h20m 13:30:53 INFO - updating [ ] 1900/148481 1h19m 13:30:53 INFO - updating [ ] 2000/148481 1h20m 13:30:53 INFO - updating [ ] 2100/148481 1h21m 13:30:53 INFO - updating [ ] 2200/148481 1h21m 13:30:53 INFO - updating [ ] 2300/148481 1h21m 13:30:53 INFO - updating [ ] 2400/148481 1h21m 13:30:53 INFO - updating [ ] 2500/148481 1h20m 13:30:53 INFO - updating [ ] 2600/148481 1h19m 13:30:53 INFO - updating [ ] 2700/148481 1h18m 13:30:53 INFO - updating [ ] 2800/148481 1h16m 13:30:53 INFO - updating [ ] 2900/148481 1h16m 13:30:53 INFO - updating [ ] 3000/148481 1h16m 13:30:53 INFO - updating [ ] 3100/148481 1h15m 13:30:53 INFO - updating [> ] 3200/148481 1h16m 13:30:53 INFO - updating [> ] 3300/148481 1h16m 13:30:53 INFO - updating [> ] 3400/148481 1h16m 13:30:53 INFO - updating [> ] 3500/148481 1h16m 13:30:53 INFO - updating [> ] 3600/148481 1h16m 13:30:53 INFO - updating [> ] 3700/148481 1h15m 13:30:53 INFO - updating [> ] 3800/148481 1h15m 13:30:53 INFO - updating [> ] 3900/148481 1h15m 13:30:53 INFO - updating [> ] 4000/148481 1h16m 13:30:53 INFO - updating [> ] 4100/148481 1h16m 13:30:53 INFO - updating [> ] 4200/148481 1h16m 13:30:53 INFO - updating [> ] 4300/148481 1h16m 13:30:53 INFO - updating [> ] 4400/148481 1h15m 13:30:53 INFO - updating [> ] 4500/148481 1h15m 13:30:53 INFO - updating [> ] 4600/148481 1h15m 13:30:53 INFO - updating [> ] 4700/148481 1h15m 13:30:53 INFO - updating [> ] 4800/148481 1h14m 13:30:53 INFO - updating [> ] 4900/148481 1h14m 13:30:53 INFO - updating [> ] 5000/148481 1h14m 13:30:53 INFO - updating [> ] 5100/148481 1h14m 13:30:53 INFO - updating [> ] 5200/148481 1h14m 13:30:53 INFO - updating [> ] 5300/148481 1h14m 13:30:53 INFO - updating [> ] 5400/148481 1h14m 13:30:53 INFO - updating [> ] 5500/148481 1h13m 13:30:53 INFO - updating [> ] 5600/148481 1h13m 13:30:53 INFO - updating [> ] 5700/148481 1h12m 13:30:53 INFO - updating [> ] 5800/148481 1h12m 13:30:53 INFO - updating [> ] 5900/148481 1h12m 13:30:53 INFO - updating [> ] 6000/148481 1h12m 13:30:53 INFO - updating [> ] 6100/148481 1h11m 13:30:53 INFO - updating [> ] 6200/148481 1h11m 13:30:53 INFO - updating [> ] 6300/148481 1h11m 13:30:53 INFO - updating [=> ] 6400/148481 1h11m 13:30:53 INFO - updating [=> ] 6500/148481 1h10m 13:30:53 INFO - updating [=> ] 6600/148481 1h10m 13:30:53 INFO - updating [=> ] 6700/148481 1h10m 13:30:53 INFO - updating [=> ] 6800/148481 1h10m 13:30:53 INFO - updating [=> ] 6900/148481 1h10m 13:30:53 INFO - updating [=> ] 7000/148481 1h10m 13:30:53 INFO - updating [=> ] 7100/148481 1h10m 13:30:53 INFO - updating [=> ] 7200/148481 1h10m 13:30:53 INFO - updating [=> ] 7300/148481 1h10m 13:30:53 INFO - updating [=> ] 7400/148481 1h10m 13:30:53 INFO - updating [=> ] 7500/148481 1h10m 13:30:53 INFO - updating [=> ] 7600/148481 1h10m 13:30:53 INFO - updating [=> ] 7700/148481 1h10m 13:30:53 INFO - updating [=> ] 7800/148481 1h09m 13:30:53 INFO - updating [=> ] 7900/148481 1h09m 13:30:53 INFO - updating [=> ] 8000/148481 1h09m 13:30:53 INFO - updating [=> ] 8100/148481 1h09m 13:30:53 INFO - updating [=> ] 8200/148481 1h09m 13:30:53 INFO - updating [=> ] 8300/148481 1h09m 13:30:53 INFO - updating [=> ] 8400/148481 1h09m 13:30:53 INFO - updating [=> ] 8500/148481 1h09m 13:30:53 INFO - updating [=> ] 8600/148481 1h09m 13:30:53 INFO - updating [=> ] 8700/148481 1h09m 13:30:53 INFO - updating [=> ] 8800/148481 1h10m 13:30:53 INFO - updating [=> ] 8900/148481 1h10m 13:30:53 INFO - updating [=> ] 9000/148481 1h10m 13:30:53 INFO - updating [=> ] 9100/148481 1h10m 13:30:53 INFO - updating [=> ] 9200/148481 1h10m 13:30:53 INFO - updating [=> ] 9300/148481 1h10m 13:30:53 INFO - updating [=> ] 9400/148481 1h10m 13:30:53 INFO - updating [==> ] 9500/148481 1h11m 13:30:53 INFO - updating [==> ] 9600/148481 1h11m 13:30:53 INFO - updating [==> ] 9700/148481 1h11m 13:30:53 INFO - updating [==> ] 9800/148481 1h11m 13:30:53 INFO - updating [==> ] 9900/148481 1h11m 13:30:53 INFO - updating [==> ] 10000/148481 1h11m 13:30:53 INFO - updating [==> ] 10100/148481 1h11m 13:30:53 INFO - updating [==> ] 10200/148481 1h11m 13:30:53 INFO - updating [==> ] 10300/148481 1h11m 13:30:53 INFO - updating [==> ] 10400/148481 1h11m 13:30:53 INFO - updating [==> ] 10500/148481 1h11m 13:30:53 INFO - updating [==> ] 10600/148481 1h11m 13:30:53 INFO - updating [==> ] 10700/148481 1h11m 13:30:53 INFO - updating [==> ] 10800/148481 1h10m 13:30:53 INFO - updating [==> ] 10900/148481 1h10m 13:30:53 INFO - updating [==> ] 11000/148481 1h10m 13:30:53 INFO - updating [==> ] 11100/148481 1h11m 13:30:53 INFO - updating [==> ] 11200/148481 1h11m 13:30:53 INFO - updating [==> ] 11300/148481 1h10m 13:30:53 INFO - updating [==> ] 11400/148481 1h10m 13:30:53 INFO - updating [==> ] 11500/148481 1h10m 13:30:53 INFO - updating [==> ] 11600/148481 1h10m 13:30:53 INFO - updating [==> ] 11700/148481 1h10m 13:30:53 INFO - updating [==> ] 11800/148481 1h10m 13:30:53 INFO - updating [==> ] 11900/148481 1h10m 13:30:53 INFO - updating [==> ] 12000/148481 1h10m 13:30:53 INFO - updating [==> ] 12100/148481 1h10m 13:30:53 INFO - updating [==> ] 12200/148481 1h10m 13:30:53 INFO - updating [==> ] 12300/148481 1h10m 13:30:53 INFO - updating [==> ] 12400/148481 1h09m 13:30:53 INFO - updating [==> ] 12500/148481 1h09m 13:30:53 INFO - updating [==> ] 12600/148481 1h09m 13:30:53 INFO - updating [===> ] 12700/148481 1h09m 13:30:53 INFO - updating [===> ] 12800/148481 1h09m 13:30:53 INFO - updating [===> ] 12900/148481 1h09m 13:30:53 INFO - updating [===> ] 13000/148481 1h09m 13:30:53 INFO - updating [===> ] 13100/148481 1h09m 13:30:53 INFO - updating [===> ] 13200/148481 1h09m 13:30:53 INFO - updating [===> ] 13300/148481 1h09m 13:30:53 INFO - updating [===> ] 13400/148481 1h08m 13:30:53 INFO - updating [===> ] 13500/148481 1h09m 13:30:53 INFO - updating [===> ] 13600/148481 1h09m 13:30:53 INFO - updating [===> ] 13700/148481 1h09m 13:30:53 INFO - updating [===> ] 13800/148481 1h09m 13:30:53 INFO - updating [===> ] 13900/148481 1h08m 13:30:53 INFO - updating [===> ] 14000/148481 1h08m 13:30:53 INFO - updating [===> ] 14100/148481 1h08m 13:30:53 INFO - updating [===> ] 14200/148481 1h08m 13:30:53 INFO - updating [===> ] 14300/148481 1h08m 13:30:53 INFO - updating [===> ] 14400/148481 1h07m 13:30:53 INFO - updating [===> ] 14500/148481 1h07m 13:30:53 INFO - updating [===> ] 14600/148481 1h07m 13:30:53 INFO - updating [===> ] 14700/148481 1h07m 13:30:53 INFO - updating [===> ] 14800/148481 1h06m 13:30:53 INFO - updating [===> ] 14900/148481 1h06m 13:30:53 INFO - updating [===> ] 15000/148481 1h06m 13:30:53 INFO - updating [===> ] 15100/148481 1h06m 13:30:53 INFO - updating [===> ] 15200/148481 1h06m 13:30:53 INFO - updating [===> ] 15300/148481 1h06m 13:30:53 INFO - updating [===> ] 15400/148481 1h06m 13:30:53 INFO - updating [===> ] 15500/148481 1h06m 13:30:53 INFO - updating [===> ] 15600/148481 1h06m 13:30:53 INFO - updating [===> ] 15700/148481 1h06m 13:30:53 INFO - updating [====> ] 15800/148481 1h05m 13:30:53 INFO - updating [====> ] 15900/148481 1h05m 13:30:53 INFO - updating [====> ] 16000/148481 1h05m 13:30:53 INFO - updating [====> ] 16100/148481 1h05m 13:30:53 INFO - updating [====> ] 16200/148481 1h06m 13:30:53 INFO - updating [====> ] 16300/148481 1h06m 13:30:53 INFO - updating [====> ] 16400/148481 1h06m 13:30:53 INFO - updating [====> ] 16500/148481 1h06m 13:30:53 INFO - updating [====> ] 16600/148481 1h06m 13:30:53 INFO - updating [====> ] 16700/148481 1h06m 13:30:53 INFO - updating [====> ] 16800/148481 1h07m 13:30:53 INFO - updating [====> ] 16900/148481 1h07m 13:30:53 INFO - updating [====> ] 17000/148481 1h07m 13:30:53 INFO - updating [====> ] 17100/148481 1h06m 13:30:53 INFO - updating [====> ] 17200/148481 1h06m 13:30:53 INFO - updating [====> ] 17300/148481 1h06m 13:30:53 INFO - updating [====> ] 17400/148481 1h06m 13:30:53 INFO - updating [====> ] 17500/148481 1h06m 13:30:53 INFO - updating [====> ] 17600/148481 1h06m 13:30:53 INFO - updating [====> ] 17700/148481 1h06m 13:30:53 INFO - updating [====> ] 17800/148481 1h06m 13:30:53 INFO - updating [====> ] 17900/148481 1h05m 13:30:53 INFO - updating [====> ] 18000/148481 1h05m 13:30:53 INFO - updating [====> ] 18100/148481 1h05m 13:30:53 INFO - updating [====> ] 18200/148481 1h05m 13:30:53 INFO - updating [====> ] 18300/148481 1h05m 13:30:53 INFO - updating [====> ] 18400/148481 1h05m 13:30:53 INFO - updating [====> ] 18500/148481 1h04m 13:30:53 INFO - updating [====> ] 18600/148481 1h04m 13:30:53 INFO - updating [====> ] 18700/148481 1h04m 13:30:53 INFO - updating [====> ] 18800/148481 1h04m 13:30:53 INFO - updating [====> ] 18900/148481 1h04m 13:30:53 INFO - updating [=====> ] 19000/148481 1h04m 13:30:53 INFO - updating [=====> ] 19100/148481 1h03m 13:30:53 INFO - updating [=====> ] 19200/148481 1h03m 13:30:53 INFO - updating [=====> ] 19300/148481 1h03m 13:30:53 INFO - updating [=====> ] 19400/148481 1h03m 13:30:53 INFO - updating [=====> ] 19500/148481 1h03m 13:30:53 INFO - updating [=====> ] 19600/148481 1h03m 13:30:53 INFO - updating [=====> ] 19700/148481 1h03m 13:30:53 INFO - updating [=====> ] 19800/148481 1h03m 13:30:53 INFO - updating [=====> ] 19900/148481 1h03m 13:30:53 INFO - updating [=====> ] 20000/148481 1h03m 13:30:53 INFO - updating [=====> ] 20100/148481 1h03m 13:30:53 INFO - updating [=====> ] 20200/148481 1h02m 13:30:53 INFO - updating [=====> ] 20300/148481 1h02m 13:30:53 INFO - updating [=====> ] 20400/148481 1h02m 13:30:53 INFO - updating [=====> ] 20500/148481 1h02m 13:30:53 INFO - updating [=====> ] 20600/148481 1h02m 13:30:53 INFO - updating [=====> ] 20700/148481 1h02m 13:30:53 INFO - updating [=====> ] 20800/148481 1h01m 13:30:53 INFO - updating [=====> ] 20900/148481 1h01m 13:30:53 INFO - updating [=====> ] 21000/148481 1h01m 13:30:53 INFO - updating [=====> ] 21100/148481 1h01m 13:30:53 INFO - updating [=====> ] 21200/148481 1h01m 13:30:53 INFO - updating [=====> ] 21300/148481 59m51s 13:30:53 INFO - updating [=====> ] 21400/148481 59m39s 13:30:53 INFO - updating [=====> ] 21500/148481 59m27s 13:30:53 INFO - updating [=====> ] 21700/148481 58m59s 13:30:53 INFO - updating [=====> ] 21900/148481 58m28s 13:30:53 INFO - updating [=====> ] 22100/148481 58m01s 13:30:53 INFO - updating [=====> ] 22200/148481 57m50s 13:30:53 INFO - updating [=====> ] 22300/148481 57m41s 13:30:53 INFO - updating [=====> ] 22400/148481 57m34s 13:30:53 INFO - updating [=====> ] 22500/148481 57m25s 13:30:53 INFO - updating [======> ] 22600/148481 57m17s 13:30:53 INFO - updating [======> ] 22700/148481 57m05s 13:30:53 INFO - updating [======> ] 22800/148481 57m03s 13:30:53 INFO - updating [======> ] 22900/148481 57m03s 13:30:53 INFO - updating [======> ] 23000/148481 57m02s 13:30:53 INFO - updating [======> ] 23100/148481 56m52s 13:30:53 INFO - updating [======> ] 23200/148481 56m43s 13:30:53 INFO - updating [======> ] 23300/148481 56m35s 13:30:53 INFO - updating [======> ] 23400/148481 56m30s 13:30:53 INFO - updating [======> ] 23500/148481 56m21s 13:30:53 INFO - updating [======> ] 23600/148481 56m17s 13:30:53 INFO - updating [======> ] 23700/148481 56m08s 13:30:53 INFO - updating [======> ] 23800/148481 55m58s 13:30:53 INFO - updating [======> ] 23900/148481 55m52s 13:30:53 INFO - updating [======> ] 24000/148481 55m42s 13:30:53 INFO - updating [======> ] 24100/148481 55m42s 13:30:53 INFO - updating [======> ] 24200/148481 55m43s 13:30:53 INFO - updating [======> ] 24300/148481 55m39s 13:30:53 INFO - updating [======> ] 24400/148481 55m33s 13:30:53 INFO - updating [======> ] 24500/148481 55m30s 13:30:53 INFO - updating [======> ] 24600/148481 55m26s 13:30:53 INFO - updating [======> ] 24700/148481 55m27s 13:30:53 INFO - updating [======> ] 24800/148481 55m23s 13:30:53 INFO - updating [======> ] 24900/148481 55m18s 13:30:53 INFO - updating [======> ] 25000/148481 55m14s 13:30:53 INFO - updating [======> ] 25100/148481 55m08s 13:30:53 INFO - updating [======> ] 25200/148481 55m07s 13:30:53 INFO - updating [======> ] 25300/148481 55m06s 13:30:53 INFO - updating [======> ] 25400/148481 55m05s 13:30:53 INFO - updating [======> ] 25500/148481 54m59s 13:30:53 INFO - updating [======> ] 25600/148481 54m53s 13:30:53 INFO - updating [======> ] 25700/148481 54m49s 13:30:53 INFO - updating [======> ] 25800/148481 54m44s 13:30:53 INFO - updating [=======> ] 25900/148481 54m44s 13:30:53 INFO - updating [=======> ] 26000/148481 54m41s 13:30:53 INFO - updating [=======> ] 26100/148481 54m39s 13:30:53 INFO - updating [=======> ] 26200/148481 54m37s 13:30:53 INFO - updating [=======> ] 26300/148481 54m33s 13:30:53 INFO - updating [=======> ] 26400/148481 54m28s 13:30:53 INFO - updating [=======> ] 26500/148481 54m22s 13:30:53 INFO - updating [=======> ] 26600/148481 54m20s 13:30:53 INFO - updating [=======> ] 26700/148481 54m12s 13:30:53 INFO - updating [=======> ] 26800/148481 54m10s 13:30:53 INFO - updating [=======> ] 26900/148481 54m08s 13:30:53 INFO - updating [=======> ] 27000/148481 54m06s 13:30:53 INFO - updating [=======> ] 27100/148481 53m58s 13:30:53 INFO - updating [=======> ] 27200/148481 53m50s 13:30:53 INFO - updating [=======> ] 27300/148481 53m48s 13:30:53 INFO - updating [=======> ] 27400/148481 53m41s 13:30:53 INFO - updating [=======> ] 27500/148481 53m31s 13:30:53 INFO - updating [=======> ] 27600/148481 53m22s 13:30:53 INFO - updating [=======> ] 27700/148481 53m14s 13:30:53 INFO - updating [=======> ] 27900/148481 52m55s 13:30:53 INFO - updating [=======> ] 28000/148481 52m46s 13:30:53 INFO - updating [=======> ] 28100/148481 52m37s 13:30:53 INFO - updating [=======> ] 28200/148481 52m31s 13:30:53 INFO - updating [=======> ] 28300/148481 52m25s 13:30:53 INFO - updating [=======> ] 28400/148481 52m20s 13:30:53 INFO - updating [=======> ] 28500/148481 52m17s 13:30:53 INFO - updating [=======> ] 28600/148481 52m09s 13:30:53 INFO - updating [=======> ] 28700/148481 52m00s 13:30:53 INFO - updating [=======> ] 28800/148481 51m55s 13:30:53 INFO - updating [=======> ] 28900/148481 51m48s 13:30:53 INFO - updating [=======> ] 29000/148481 51m44s 13:30:53 INFO - updating [========> ] 29100/148481 51m41s 13:30:53 INFO - updating [========> ] 29200/148481 51m37s 13:30:53 INFO - updating [========> ] 29300/148481 51m29s 13:30:53 INFO - updating [========> ] 29400/148481 51m21s 13:30:53 INFO - updating [========> ] 29500/148481 51m12s 13:30:53 INFO - updating [========> ] 29700/148481 50m58s 13:30:53 INFO - updating [========> ] 29800/148481 50m56s 13:30:53 INFO - updating [========> ] 29900/148481 50m51s 13:30:53 INFO - updating [========> ] 30000/148481 50m46s 13:30:53 INFO - updating [========> ] 30100/148481 50m43s 13:30:53 INFO - updating [========> ] 30200/148481 50m35s 13:30:53 INFO - updating [========> ] 30300/148481 50m31s 13:30:53 INFO - updating [========> ] 30400/148481 50m23s 13:30:53 INFO - updating [========> ] 30500/148481 50m19s 13:30:53 INFO - updating [========> ] 30600/148481 50m20s 13:30:53 INFO - updating [========> ] 30700/148481 50m17s 13:30:53 INFO - updating [========> ] 30800/148481 50m08s 13:30:53 INFO - updating [========> ] 30900/148481 50m06s 13:30:53 INFO - updating [========> ] 31000/148481 50m06s 13:30:53 INFO - updating [========> ] 31100/148481 50m06s 13:30:53 INFO - updating [========> ] 31200/148481 50m08s 13:30:53 INFO - updating [========> ] 31300/148481 50m12s 13:30:53 INFO - updating [========> ] 31400/148481 50m11s 13:30:53 INFO - updating [========> ] 31500/148481 50m11s 13:30:53 INFO - updating [========> ] 31600/148481 50m12s 13:30:53 INFO - updating [========> ] 31700/148481 50m11s 13:30:53 INFO - updating [========> ] 31800/148481 50m12s 13:30:53 INFO - updating [========> ] 31900/148481 50m14s 13:30:53 INFO - updating [========> ] 32000/148481 50m13s 13:30:53 INFO - updating [========> ] 32100/148481 50m12s 13:30:53 INFO - updating [========> ] 32200/148481 50m06s 13:30:53 INFO - updating [=========> ] 32300/148481 50m02s 13:30:53 INFO - updating [=========> ] 32400/148481 49m56s 13:30:53 INFO - updating [=========> ] 32500/148481 49m51s 13:30:53 INFO - updating [=========> ] 32700/148481 49m33s 13:30:53 INFO - updating [=========> ] 32800/148481 49m29s 13:30:53 INFO - updating [=========> ] 32900/148481 49m23s 13:30:53 INFO - updating [=========> ] 33000/148481 49m18s 13:30:53 INFO - updating [=========> ] 33100/148481 49m14s 13:30:53 INFO - updating [=========> ] 33200/148481 49m08s 13:30:53 INFO - updating [=========> ] 33300/148481 49m01s 13:30:53 INFO - updating [=========> ] 33400/148481 48m55s 13:30:53 INFO - updating [=========> ] 33500/148481 48m49s 13:30:53 INFO - updating [=========> ] 33600/148481 48m44s 13:30:53 INFO - updating [=========> ] 33700/148481 48m38s 13:30:53 INFO - updating [=========> ] 33800/148481 48m33s 13:30:53 INFO - updating [=========> ] 33900/148481 48m27s 13:30:53 INFO - updating [=========> ] 34000/148481 48m23s 13:30:53 INFO - updating [=========> ] 34200/148481 48m08s 13:30:53 INFO - updating [=========> ] 34300/148481 48m04s 13:30:53 INFO - updating [=========> ] 34400/148481 47m59s 13:30:53 INFO - updating [=========> ] 34500/148481 47m57s 13:30:53 INFO - updating [=========> ] 34600/148481 47m50s 13:30:53 INFO - updating [=========> ] 34700/148481 47m46s 13:30:53 INFO - updating [=========> ] 34800/148481 47m40s 13:30:53 INFO - updating [=========> ] 34900/148481 47m33s 13:30:53 INFO - updating [=========> ] 35000/148481 47m26s 13:30:53 INFO - updating [=========> ] 35100/148481 47m21s 13:30:53 INFO - updating [=========> ] 35200/148481 47m14s 13:30:53 INFO - updating [=========> ] 35300/148481 47m10s 13:30:53 INFO - updating [=========> ] 35400/148481 47m03s 13:30:53 INFO - updating [=========> ] 35500/148481 46m58s 13:30:53 INFO - updating [==========> ] 35600/148481 46m54s 13:30:53 INFO - updating [==========> ] 35700/148481 46m48s 13:30:53 INFO - updating [==========> ] 35800/148481 46m46s 13:30:53 INFO - updating [==========> ] 35900/148481 46m42s 13:30:53 INFO - updating [==========> ] 36100/148481 46m27s 13:30:53 INFO - updating [==========> ] 36300/148481 46m13s 13:30:53 INFO - updating [==========> ] 36400/148481 46m10s 13:30:53 INFO - updating [==========> ] 36500/148481 46m06s 13:30:53 INFO - updating [==========> ] 36600/148481 46m00s 13:30:53 INFO - updating [==========> ] 36700/148481 45m54s 13:30:53 INFO - updating [==========> ] 36800/148481 45m47s 13:30:53 INFO - updating [==========> ] 36900/148481 45m45s 13:30:53 INFO - updating [==========> ] 37300/148481 45m09s 13:30:53 INFO - updating [==========> ] 37700/148481 44m34s 13:30:53 INFO - updating [==========> ] 38000/148481 44m11s 13:30:53 INFO - updating [==========> ] 38100/148481 44m09s 13:30:53 INFO - updating [==========> ] 38200/148481 44m04s 13:30:53 INFO - updating [==========> ] 38300/148481 43m59s 13:30:53 INFO - updating [==========> ] 38400/148481 43m53s 13:30:53 INFO - updating [==========> ] 38500/148481 43m47s 13:30:53 INFO - updating [==========> ] 38700/148481 43m36s 13:30:53 INFO - updating [===========> ] 38800/148481 43m33s 13:30:53 INFO - updating [===========> ] 38900/148481 43m30s 13:30:53 INFO - updating [===========> ] 39000/148481 43m28s 13:30:53 INFO - updating [===========> ] 39100/148481 43m25s 13:30:53 INFO - updating [===========> ] 39200/148481 43m20s 13:30:53 INFO - updating [===========> ] 39300/148481 43m19s 13:30:53 INFO - updating [===========> ] 39400/148481 43m19s 13:30:53 INFO - updating [===========> ] 39500/148481 43m13s 13:30:53 INFO - updating [===========> ] 40000/148481 42m33s 13:30:53 INFO - updating [===========> ] 40500/148481 41m53s 13:30:53 INFO - updating [===========> ] 40900/148481 41m22s 13:30:53 INFO - updating [===========> ] 41400/148481 40m43s 13:30:53 INFO - updating [===========> ] 41700/148481 40m22s 13:30:53 INFO - updating [============> ] 42200/148481 39m45s 13:30:53 INFO - updating [============> ] 42800/148481 39m01s 13:30:53 INFO - updating [============> ] 43100/148481 38m41s 13:30:53 INFO - updating [============> ] 43400/148481 38m21s 13:30:53 INFO - updating [============> ] 44000/148481 37m39s 13:30:53 INFO - updating [============> ] 44600/148481 36m58s 13:30:53 INFO - updating [============> ] 44900/148481 36m39s 13:30:53 INFO - updating [=============> ] 45300/148481 36m14s 13:30:53 INFO - updating [=============> ] 45800/148481 35m42s 13:30:53 INFO - updating [=============> ] 46400/148481 35m05s 13:30:53 INFO - updating [=============> ] 46800/148481 34m41s 13:30:53 INFO - updating [=============> ] 47400/148481 34m05s 13:30:53 INFO - updating [=============> ] 47600/148481 33m55s 13:30:53 INFO - updating [=============> ] 48100/148481 33m26s 13:30:53 INFO - updating [==============> ] 48600/148481 32m58s 13:30:53 INFO - updating [==============> ] 49000/148481 32m36s 13:30:53 INFO - updating [==============> ] 49500/148481 32m08s 13:30:53 INFO - updating [==============> ] 49900/148481 31m48s 13:30:53 INFO - updating [==============> ] 50500/148481 31m16s 13:30:53 INFO - updating [==============> ] 51200/148481 30m39s 13:30:53 INFO - updating [===============> ] 52100/148481 29m53s 13:30:53 INFO - updating [===============> ] 52800/148481 29m18s 13:30:53 INFO - updating [===============> ] 53500/148481 28m44s 13:30:53 INFO - updating [===============> ] 54500/148481 27m56s 13:30:53 INFO - updating [================> ] 55300/148481 27m20s 13:30:53 INFO - updating [================> ] 55700/148481 27m03s 13:30:53 INFO - updating [================> ] 55900/148481 26m56s 13:30:53 INFO - updating [================> ] 56200/148481 26m44s 13:30:53 INFO - updating [================> ] 56900/148481 26m14s 13:30:53 INFO - updating [================> ] 57400/148481 25m53s 13:30:53 INFO - updating [================> ] 58100/148481 25m24s 13:30:53 INFO - updating [=================> ] 58500/148481 25m09s 13:30:53 INFO - updating [=================> ] 59200/148481 24m41s 13:30:53 INFO - updating [=================> ] 59700/148481 24m22s 13:30:53 INFO - updating [=================> ] 60400/148481 23m55s 13:30:53 INFO - updating [=================> ] 61100/148481 23m29s 13:30:53 INFO - updating [==================> ] 61700/148481 23m08s 13:30:53 INFO - updating [==================> ] 62700/148481 22m31s 13:30:53 INFO - updating [==================> ] 63400/148481 22m07s 13:30:53 INFO - updating [==================> ] 64300/148481 21m36s 13:30:53 INFO - updating [==================> ] 64500/148481 21m30s 13:30:53 INFO - updating [===================> ] 65000/148481 21m14s 13:30:53 INFO - updating [===================> ] 65500/148481 20m58s 13:30:53 INFO - updating [===================> ] 66100/148481 20m39s 13:30:53 INFO - updating [===================> ] 66900/148481 20m15s 13:30:53 INFO - updating [===================> ] 67600/148481 19m54s 13:30:53 INFO - updating [====================> ] 68100/148481 19m39s 13:30:53 INFO - updating [====================> ] 68900/148481 19m15s 13:30:53 INFO - updating [====================> ] 69600/148481 18m54s 13:30:53 INFO - updating [====================> ] 70400/148481 18m31s 13:30:53 INFO - updating [=====================> ] 71300/148481 18m06s 13:30:53 INFO - updating [=====================> ] 72300/148481 17m38s 13:30:53 INFO - updating [=====================> ] 73000/148481 17m19s 13:30:53 INFO - updating [=====================> ] 73800/148481 16m58s 13:30:53 INFO - updating [======================> ] 74400/148481 16m43s 13:30:53 INFO - updating [======================> ] 75300/148481 16m20s 13:30:53 INFO - updating [======================> ] 76000/148481 16m03s 13:30:53 INFO - updating [======================> ] 76500/148481 15m51s 13:30:53 INFO - updating [======================> ] 77200/148481 15m34s 13:30:53 INFO - updating [=======================> ] 77700/148481 15m23s 13:30:53 INFO - updating [=======================> ] 78800/148481 14m57s 13:30:53 INFO - updating [=======================> ] 79400/148481 14m43s 13:30:53 INFO - updating [=======================> ] 80200/148481 14m25s 13:30:53 INFO - updating [========================> ] 80900/148481 14m10s 13:30:53 INFO - updating [========================> ] 81500/148481 13m57s 13:30:53 INFO - updating [========================> ] 82400/148481 13m38s 13:30:53 INFO - updating [========================> ] 83100/148481 13m23s 13:30:53 INFO - updating [=========================> ] 84000/148481 13m05s 13:30:53 INFO - updating [=========================> ] 84700/148481 12m50s 13:30:53 INFO - updating [=========================> ] 85500/148481 12m34s 13:30:53 INFO - updating [=========================> ] 86100/148481 12m23s 13:30:53 INFO - updating [=========================> ] 86800/148481 12m10s 13:30:53 INFO - updating [=========================> ] 87100/148481 12m04s 13:30:53 INFO - updating [==========================> ] 87800/148481 11m51s 13:30:53 INFO - updating [==========================> ] 88400/148481 11m40s 13:30:53 INFO - updating [==========================> ] 89100/148481 11m27s 13:30:53 INFO - updating [==========================> ] 89700/148481 11m16s 13:30:53 INFO - updating [==========================> ] 90000/148481 11m12s 13:30:53 INFO - updating [===========================> ] 90500/148481 11m03s 13:30:53 INFO - updating [===========================> ] 91100/148481 10m53s 13:30:53 INFO - updating [===========================> ] 91500/148481 10m46s 13:30:53 INFO - updating [===========================> ] 91900/148481 10m39s 13:30:53 INFO - updating [===========================> ] 92300/148481 10m33s 13:30:53 INFO - updating [===========================> ] 93000/148481 10m21s 13:30:53 INFO - updating [============================> ] 93900/148481 10m06s 13:30:53 INFO - updating [============================> ] 94500/148481 9m56s 13:30:53 INFO - updating [=============================> ] 94900/148481 9m49s 13:30:53 INFO - updating [=============================> ] 95400/148481 9m42s 13:30:53 INFO - updating [=============================> ] 96000/148481 9m32s 13:30:53 INFO - updating [=============================> ] 96400/148481 9m26s 13:30:53 INFO - updating [=============================> ] 96800/148481 9m20s 13:30:53 INFO - updating [=============================> ] 97400/148481 9m11s 13:30:53 INFO - updating [=============================> ] 97900/148481 9m03s 13:30:53 INFO - updating [==============================> ] 98400/148481 8m56s 13:30:53 INFO - updating [==============================> ] 98700/148481 8m51s 13:30:53 INFO - updating [==============================> ] 99200/148481 8m44s 13:30:53 INFO - updating [==============================> ] 99700/148481 8m37s 13:30:53 INFO - updating [==============================> ] 100100/148481 8m31s 13:30:53 INFO - updating [==============================> ] 100600/148481 8m24s 13:30:53 INFO - updating [===============================> ] 101100/148481 8m17s 13:30:53 INFO - updating [===============================> ] 101600/148481 8m10s 13:30:53 INFO - updating [===============================> ] 102200/148481 8m01s 13:30:53 INFO - updating [===============================> ] 102600/148481 7m56s 13:30:53 INFO - updating [===============================> ] 102900/148481 7m52s 13:30:53 INFO - updating [===============================> ] 103500/148481 7m43s 13:30:53 INFO - updating [===============================> ] 103800/148481 7m39s 13:30:53 INFO - updating [===============================> ] 104200/148481 7m34s 13:30:53 INFO - updating [================================> ] 104600/148481 7m29s 13:30:53 INFO - updating [================================> ] 105300/148481 7m19s 13:30:53 INFO - updating [================================> ] 105800/148481 7m12s 13:30:53 INFO - updating [================================> ] 106500/148481 7m03s 13:30:53 INFO - updating [================================> ] 106900/148481 6m58s 13:30:53 INFO - updating [================================> ] 107400/148481 6m51s 13:30:53 INFO - updating [=================================> ] 108000/148481 6m43s 13:30:53 INFO - updating [=================================> ] 108500/148481 6m37s 13:30:53 INFO - updating [=================================> ] 109000/148481 6m30s 13:30:53 INFO - updating [=================================> ] 109700/148481 6m21s 13:30:53 INFO - updating [=================================> ] 110300/148481 6m14s 13:30:53 INFO - updating [==================================> ] 110800/148481 6m08s 13:30:53 INFO - updating [==================================> ] 111300/148481 6m02s 13:30:53 INFO - updating [==================================> ] 111700/148481 5m57s 13:30:53 INFO - updating [==================================> ] 112200/148481 5m51s 13:30:53 INFO - updating [==================================> ] 112500/148481 5m47s 13:30:53 INFO - updating [==================================> ] 112700/148481 5m45s 13:30:53 INFO - updating [==================================> ] 113200/148481 5m39s 13:30:53 INFO - updating [==================================> ] 113600/148481 5m34s 13:30:53 INFO - updating [===================================> ] 114200/148481 5m27s 13:30:53 INFO - updating [===================================> ] 114700/148481 5m22s 13:30:53 INFO - updating [===================================> ] 115400/148481 5m13s 13:30:53 INFO - updating [===================================> ] 115900/148481 5m08s 13:30:53 INFO - updating [===================================> ] 116300/148481 5m03s 13:30:53 INFO - updating [====================================> ] 117000/148481 4m55s 13:30:53 INFO - updating [====================================> ] 117500/148481 4m49s 13:30:53 INFO - updating [====================================> ] 118300/148481 4m40s 13:30:53 INFO - updating [====================================> ] 119000/148481 4m33s 13:30:53 INFO - updating [====================================> ] 119300/148481 4m29s 13:30:53 INFO - updating [====================================> ] 119900/148481 4m23s 13:30:53 INFO - updating [=====================================> ] 120700/148481 4m14s 13:30:53 INFO - updating [=====================================> ] 121300/148481 4m07s 13:30:53 INFO - updating [=====================================> ] 122200/148481 3m58s 13:30:53 INFO - updating [=====================================> ] 122900/148481 3m51s 13:30:53 INFO - updating [======================================> ] 123800/148481 3m41s 13:30:53 INFO - updating [======================================> ] 124500/148481 3m34s 13:30:53 INFO - updating [======================================> ] 125100/148481 3m28s 13:30:53 INFO - updating [======================================> ] 125700/148481 3m22s 13:30:53 INFO - updating [=======================================> ] 126400/148481 3m15s 13:30:53 INFO - updating [=======================================> ] 127300/148481 3m06s 13:30:53 INFO - updating [=======================================> ] 127800/148481 3m01s 13:30:53 INFO - updating [=======================================> ] 128600/148481 2m53s 13:30:53 INFO - updating [=======================================> ] 129200/148481 2m47s 13:30:53 INFO - updating [========================================> ] 130000/148481 2m39s 13:30:53 INFO - updating [========================================> ] 130500/148481 2m35s 13:30:53 INFO - updating [========================================> ] 130800/148481 2m32s 13:30:53 INFO - updating [========================================> ] 131500/148481 2m25s 13:30:53 INFO - updating [========================================> ] 132000/148481 2m21s 13:30:53 INFO - updating [========================================> ] 132600/148481 2m15s 13:30:53 INFO - updating [=========================================> ] 133000/148481 2m11s 13:30:53 INFO - updating [=========================================> ] 133100/148481 2m11s 13:30:53 INFO - updating [=========================================> ] 133700/148481 2m05s 13:30:53 INFO - updating [=========================================> ] 134400/148481 1m59s 13:30:53 INFO - updating [=========================================> ] 135100/148481 1m52s 13:30:53 INFO - updating [=========================================> ] 135500/148481 1m49s 13:30:53 INFO - updating [==========================================> ] 136100/148481 1m43s 13:30:53 INFO - updating [==========================================> ] 136600/148481 1m39s 13:30:53 INFO - updating [==========================================> ] 137300/148481 1m33s 13:30:53 INFO - updating [==========================================> ] 137800/148481 1m28s 13:30:53 INFO - updating [==========================================> ] 138300/148481 1m24s 13:30:53 INFO - updating [==========================================> ] 138900/148481 1m19s 13:30:53 INFO - updating [===========================================> ] 139700/148481 1m12s 13:30:53 INFO - updating [===========================================> ] 140100/148481 1m09s 13:30:53 INFO - updating [===========================================> ] 140800/148481 1m03s 13:30:53 INFO - updating [=============================================> ] 141300/148481 58s 13:30:53 INFO - updating [=============================================> ] 141700/148481 55s 13:30:53 INFO - updating [=============================================> ] 142300/148481 50s 13:30:53 INFO - updating [==============================================> ] 142700/148481 47s 13:30:53 INFO - updating [==============================================> ] 143000/148481 44s 13:30:53 INFO - updating [==============================================> ] 143400/148481 41s 13:30:53 INFO - updating [==============================================> ] 143800/148481 38s 13:30:53 INFO - updating [==============================================> ] 144300/148481 34s 13:30:53 INFO - updating [==============================================> ] 144800/148481 30s 13:30:53 INFO - updating [==============================================> ] 145100/148481 27s 13:30:53 INFO - updating [===============================================> ] 145600/148481 23s 13:30:53 INFO - updating [===============================================> ] 146200/148481 19s 13:30:53 INFO - updating [===============================================> ] 146600/148481 15s 13:30:53 INFO - updating [===============================================> ] 147000/148481 12s 13:30:53 INFO - updating [===============================================> ] 147400/148481 09s 13:30:53 INFO - updating [===============================================> ] 147800/148481 06s 13:30:53 INFO - updating [===============================================> ] 148200/148481 03s 13:30:53 INFO - 13:30:53 INFO - 148481 files updated, 0 files merged, 0 files removed, 0 files unresolved 13:30:53 INFO - updated to 15a5f3920481be2c6cacf4938eedc28c77d37077 13:30:53 INFO - Return code: 0 13:30:53 INFO - Setting buildbot property comments to Merge m-c into larch 13:30:53 INFO - Writing buildbot properties ['comments'] to c:\builds\moz2_slave\l-w64-000000000000000000000000\properties\comments 13:30:53 INFO - Writing to file c:\builds\moz2_slave\l-w64-000000000000000000000000\properties\comments 13:30:53 INFO - Contents: 13:30:53 INFO - comments:Merge m-c into larch 13:30:53 INFO - Setting buildbot property got_revision to 15a5f3920481 13:30:53 INFO - Writing buildbot properties ['got_revision'] to c:\builds\moz2_slave\l-w64-000000000000000000000000\properties\got_revision 13:30:53 INFO - Writing to file c:\builds\moz2_slave\l-w64-000000000000000000000000\properties\got_revision 13:30:53 INFO - Contents: 13:30:53 INFO - got_revision:15a5f3920481 13:30:53 INFO - Running post-action listener: influxdb_recording_post_action 13:30:53 INFO - Resetting dropped connection: goldiewilson-onepointtwentyone-1.c.influxdb.com c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Lib\site-packages\requests\packages\urllib3\util\ssl_.py:90: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. For more information, see https://urllib3.readthedocs.org/en/latest/security.html#insecureplatformwarning. InsecurePlatformWarning 13:30:54 INFO - [mozharness: 2016-10-11 20:30:54.069000Z] Finished checkout-sources step (success) 13:30:54 INFO - [mozharness: 2016-10-11 20:30:54.069000Z] Skipping setup-mock step. 13:30:54 INFO - [mozharness: 2016-10-11 20:30:54.070000Z] Running build step. 13:30:54 INFO - Running pre-action listener: influxdb_recording_pre_action 13:30:54 INFO - Running main action method: build 13:30:54 INFO - removing old packages... 13:30:54 INFO - There wasn't any old packages to remove. 13:30:54 INFO - Using in-tree mozconfig 13:30:54 INFO - Reading from file c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\browser/config/mozconfigs/win64/nightly 13:30:54 INFO - Contents: 13:30:54 INFO - . "$topsrcdir/build/mozconfig.win-common" 13:30:54 INFO - . "$topsrcdir/browser/config/mozconfigs/win64/common-win64" 13:30:54 INFO - . "$topsrcdir/browser/config/mozconfigs/win64/common-opt" 13:30:54 INFO - 13:30:54 INFO - ac_add_options --enable-profiling 13:30:54 INFO - ac_add_options --enable-verify-mar 13:30:54 INFO - 13:30:54 INFO - ac_add_options --with-branding=browser/branding/nightly 13:30:54 INFO - 13:30:54 INFO - . "$topsrcdir/build/mozconfig.rust" 13:30:54 INFO - 13:30:54 INFO - . "$topsrcdir/build/mozconfig.common.override" 13:30:54 INFO - . "$topsrcdir/build/mozconfig.cache" 13:30:54 INFO - mozconfig content: 13:30:54 INFO - . "$topsrcdir/build/mozconfig.win-common" 13:30:54 INFO - . "$topsrcdir/browser/config/mozconfigs/win64/common-win64" 13:30:54 INFO - . "$topsrcdir/browser/config/mozconfigs/win64/common-opt" 13:30:54 INFO - 13:30:54 INFO - ac_add_options --enable-profiling 13:30:54 INFO - ac_add_options --enable-verify-mar 13:30:54 INFO - 13:30:54 INFO - ac_add_options --with-branding=browser/branding/nightly 13:30:54 INFO - 13:30:54 INFO - . "$topsrcdir/build/mozconfig.rust" 13:30:54 INFO - 13:30:54 INFO - . "$topsrcdir/build/mozconfig.common.override" 13:30:54 INFO - . "$topsrcdir/build/mozconfig.cache" 13:30:54 INFO - Copying c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\browser/config/mozconfigs/win64/nightly to c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\.mozconfig 13:30:54 INFO - ['sh', 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\tools\\scripts\\tooltool\\tooltool_wrapper.sh', 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'https://api.pub.build.mozilla.org/tooltool/', 'setup.sh', 'c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '--authentication-file', 'c:\\builds\\relengapi.tok', '-c', '/c/builds/tooltool_cache'] 13:30:54 INFO - Running command: ['sh', 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\tools\\scripts\\tooltool\\tooltool_wrapper.sh', 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'https://api.pub.build.mozilla.org/tooltool/', 'setup.sh', 'c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '--authentication-file', 'c:\\builds\\relengapi.tok', '-c', '/c/builds/tooltool_cache'] in c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src 13:30:54 INFO - Copy/paste: sh c:\builds\moz2_slave\l-w64-000000000000000000000000\build\tools\scripts\tooltool\tooltool_wrapper.sh c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\browser/config/tooltool-manifests/win64/releng.manifest https://api.pub.build.mozilla.org/tooltool/ setup.sh c:\mozilla-build\python27\python.exe C:/mozilla-build/tooltool.py --authentication-file c:\builds\relengapi.tok -c /c/builds/tooltool_cache 13:30:54 INFO - c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\browser/config/tooltool-manifests/win64/releng.manifest content 13:30:54 INFO - ======================================================= 13:30:54 INFO - [ 13:30:54 INFO - { 13:30:54 INFO - "size": 266240, 13:30:54 INFO - "digest": "bb345b0e700ffab4d09436981f14b5de84da55a3f18a7f09ebc4364a4488acdeab8d46f447b12ac70f2da1444a68b8ce8b8675f0dae2ccf845e966d1df0f0869", 13:30:54 INFO - "algorithm": "sha512", 13:30:54 INFO - "filename": "mozmake.exe" 13:30:54 INFO - }, 13:30:54 INFO - { 13:30:54 INFO - "version": "rustc 1.11.0 (9b21dcd6a 2016-08-15) repack", 13:30:54 INFO - "size": 91329933, 13:30:54 INFO - "digest": "db97f0186db432c57698e287798940abb5946c8903f990b087ea977fb938e83f2f9ca1bf90377bc575563af3144d429cc897a36750a1978a288a42b132c3d25d", 13:30:54 INFO - "algorithm": "sha512", 13:30:54 INFO - "visibility": "public", 13:30:54 INFO - "filename": "rustc.tar.bz2", 13:30:54 INFO - "unpack": true 13:30:54 INFO - }, 13:30:54 INFO - { 13:30:54 INFO - "version": "cargo 0.13.0-nightly (e713e7f 2016-08-31)", 13:30:54 INFO - "size": 2677831, 13:30:54 INFO - "digest": "eada1edd6142dcde907f14f23c08a2a0b86f108a8fb242f62be6573bbbe1d3b2a4a04c05465d561253d6a617e18cdabee3c87d8cef9a1b5bdd20fe835ef25ff1", 13:30:54 INFO - "algorithm": "sha512", 13:30:54 INFO - "filename": "cargo.tar.bz2", 13:30:54 INFO - "unpack": true 13:30:54 INFO - }, 13:30:54 INFO - { 13:30:54 INFO - "size": 167175, 13:30:54 INFO - "digest": "0b71a936edf5bd70cf274aaa5d7abc8f77fe8e7b5593a208f805cc9436fac646b9c4f0b43c2b10de63ff3da671497d35536077ecbc72dba7f8159a38b580f831", 13:30:54 INFO - "algorithm": "sha512", 13:30:54 INFO - "filename": "sccache.tar.bz2", 13:30:54 INFO - "unpack": true 13:30:54 INFO - }, 13:30:54 INFO - { 13:30:54 INFO - "version": "Visual Studio 2015 Update 3 14.0.25425.01 / SDK 10.0.14393.0", 13:30:54 INFO - "size": 326656969, 13:30:54 INFO - "digest": "babc414ffc0457d27f5a1ed24a8e4873afbe2f1c1a4075469a27c005e1babc3b2a788f643f825efedff95b79686664c67ec4340ed535487168a3482e68559bc7", 13:30:54 INFO - "algorithm": "sha512", 13:30:54 INFO - "filename": "vs2015u3.zip", 13:30:54 INFO - "unpack": true 13:30:54 INFO - } 13:30:54 INFO - ] 13:30:54 INFO - ======================================================= 13:30:54 INFO - Fetching... 13:30:54 INFO - Executing: ['c:\\mozilla-build\\python27\\python.exe', 'C:/mozilla-build/tooltool.py', '--authentication-file', 'c:\\builds\\relengapi.tok', '-c', 'c:/builds/tooltool_cache', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--overwrite', '-m', 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\build\\src\\browser/config/tooltool-manifests/win64/releng.manifest', 'fetch'] 13:30:55 INFO - INFO - File mozmake.exe retrieved from local cache c:/builds/tooltool_cache 13:30:55 INFO - INFO - File rustc.tar.bz2 retrieved from local cache c:/builds/tooltool_cache 13:30:56 INFO - INFO - File cargo.tar.bz2 retrieved from local cache c:/builds/tooltool_cache 13:30:56 INFO - INFO - File sccache.tar.bz2 retrieved from local cache c:/builds/tooltool_cache 13:30:59 INFO - INFO - File vs2015u3.zip retrieved from local cache c:/builds/tooltool_cache 13:31:01 INFO - INFO - untarring "rustc.tar.bz2" 13:31:11 INFO - INFO - untarring "cargo.tar.bz2" 13:31:11 INFO - INFO - untarring "sccache.tar.bz2" 13:31:11 INFO - INFO - unzipping "vs2015u3.zip" 13:31:24 INFO - Return code: 0 13:31:24 WARNING - mozbuild_path could not be determined. skipping creating it. 13:31:24 INFO - Using buildbot properties: 13:31:24 INFO - { 13:31:24 INFO - "project": "", 13:31:24 INFO - "product": "firefox", 13:31:24 INFO - "script_repo_revision": "production", 13:31:24 INFO - "scheduler": "larch-firefox", 13:31:24 INFO - "repository": "", 13:31:24 INFO - "buildername": "WINNT 6.1 x86-64 larch build", 13:31:24 INFO - "buildid": "20161011124447", 13:31:24 INFO - "basedir": "/c/builds/moz2_slave/l-w64-000000000000000000000000", 13:31:24 INFO - "buildnumber": 0, 13:31:24 INFO - "platform": "win64", 13:31:24 INFO - "master": "http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/", 13:31:24 INFO - "branch": "larch", 13:31:24 INFO - "revision": "15a5f3920481be2c6cacf4938eedc28c77d37077", 13:31:24 INFO - "slavename": "b-2008-spot-106", 13:31:24 INFO - "builduid": "24735c14cd0c41d2856c32aa24e48f22", 13:31:24 INFO - "repo_path": "projects/larch" 13:31:24 INFO - } 13:31:24 INFO - Copying c:\builds\moz2_slave\l-w64-000000000000000000000000\buildprops.json to c:\builds\moz2_slave\l-w64-000000000000000000000000\build\buildprops.json 13:31:24 INFO - Running command: ['c:\\mozilla-build\\python27\\python.exe', 'mach', '--log-no-times', 'build', '-v'] in c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src 13:31:24 INFO - Copy/paste: c:\mozilla-build\python27\python.exe mach --log-no-times build -v 13:31:24 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:31:24 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:31:24 INFO - 'APR_ICONV_PATH': 'c:/mozilla-build/svn-win32-1.6.3/iconv', 13:31:24 INFO - 'BUILDBOT_PATH': 'C:\\mozilla-build\\buildbotve', 13:31:24 INFO - 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 13:31:24 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 13:31:24 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 13:31:24 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 13:31:24 INFO - 'COMPUTERNAME': 'B-2008-SPOT-106', 13:31:24 INFO - 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 13:31:24 INFO - 'CVS_RSH': 'ssh', 13:31:24 INFO - 'DXSDK_DIR': 'C:\\Program Files (x86)\\Microsoft DirectX SDK (June 2010)\\', 13:31:24 INFO - 'EDITOR': 'emacs.exe', 13:31:24 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:31:24 INFO - 'GIT_SHARE_BASE_DIR': 'C:/mozilla-build/msys/builds/git-shared', 13:31:24 INFO - 'HG_SHARE_BASE_DIR': 'C:/builds/hg-shared', 13:31:24 INFO - 'HOME': 'c:/Users/cltbld', 13:31:24 INFO - 'HOMEDRIVE': 'C:', 13:31:24 INFO - 'HOMEPATH': '\\', 13:31:24 INFO - 'HOSTTYPE': 'i686', 13:31:24 INFO - 'IDLEIZER_HALT_ON_IDLE': 'true', 13:31:24 INFO - 'INPUTRC': 'C:/mozilla-build/msys/etc/inputrc', 13:31:24 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:31:24 INFO - 'LOG': '"c:\\runner\\buildbot-startup.log"', 13:31:24 INFO - 'LOGNAME': 'cltbld', 13:31:24 INFO - 'LOGONSERVER': '\\\\B-2008-SPOT-106', 13:31:24 INFO - 'MACHTYPE': 'i686-pc-msys', 13:31:24 INFO - 'MAKE_MODE': 'unix', 13:31:24 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build', 13:31:24 INFO - 'MOZILLABUILD': 'C:\\mozilla-build', 13:31:24 INFO - 'MOZ_AUTOMATION': '1', 13:31:24 INFO - 'MOZ_BUILD_DATE': '20161011124447', 13:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:24 INFO - 'MOZ_OBJDIR': 'obj-firefox', 13:31:24 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110,gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 13:31:24 INFO - 'MOZ_SIGN_CMD': 'python c:\\\\\\\\builds\\\\\\\\moz2_slave\\\\\\\\l-w64-000000000000000000000000\\\\\\\\build\\\\\\\\tools\\\\\\\\release\\\\\\\\signing\\\\\\\\signtool.py --cachedir c:\\\\\\\\builds\\\\\\\\moz2_slave\\\\\\\\l-w64-000000000000000000000000\\\\\\\\build\\\\\\\\signing_cache -t c:\\\\\\\\builds\\\\\\\\moz2_slave\\\\\\\\l-w64-000000000000000000000000\\\\\\\\token -n c:\\\\\\\\builds\\\\\\\\moz2_slave\\\\\\\\l-w64-000000000000000000000000\\\\\\\\nonce -c c:\\\\\\\\builds\\\\\\\\moz2_slave\\\\\\\\l-w64-000000000000000000000000\\\\\\\\build\\\\\\\\tools\\\\\\\\release\\\\\\\\signing\\\\\\\\host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9110 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9110 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9110', 13:31:24 INFO - 'MOZ_SOURCE_REPO': 'https://hg.mozilla.org/projects/larch', 13:31:24 INFO - 'MOZ_TOOLS': 'C:\\mozilla-build\\moztools-x64', 13:31:24 INFO - 'MSYSTEM': 'MINGW32', 13:31:24 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:31:24 INFO - 'OLDPWD': 'c:/Users/cltbld', 13:31:24 INFO - 'OS': 'Windows_NT', 13:31:24 INFO - 'OSTYPE': 'msys', 13:31:24 INFO - 'OS_VERSION': '2008', 13:31:24 INFO - 'PATH': 'C:/mozilla-build/nsis-3.0b1;C:/mozilla-build/python27;C:/mozilla-build/buildbotve/scripts;C:\\mozilla-build\\nsis-3.0b1;C:\\mozilla-build\\nsis-2.46u;C:\\mozilla-build\\python27;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\msys\\local\\bin;c:\\mozilla-build\\wget;c:\\mozilla-build\\7zip;c:\\mozilla-build\\blat261\\full;c:\\mozilla-build\\python;c:\\mozilla-build\\svn-win32-1.6.3\\bin;c:\\mozilla-build\\upx203w;c:\\mozilla-build\\emacs-24.3\\bin;c:\\mozilla-build\\info-zip;c:\\mozilla-build\\nsis-2.46u;c:\\mozilla-build\\nsis-3.0a2;c:\\mozilla-build\\wix-351728;c:\\mozilla-build\\hg;c:\\mozilla-build\\python\\Scripts;c:\\mozilla-build\\kdiff3;c:\\mozilla-build\\yasm;c:\\mozilla-build\\mozmake;.;C:\\mozilla-build\\msys\\local\\bin;C:\\mozilla-build\\msys\\mingw\\bin;C:\\mozilla-build\\msys\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\facter\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\hiera\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\ruby\\bin;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\sys\\tools\\bin;c:\\Windows\\system32;c:\\Windows;c:\\Windows\\System32\\Wbem;c:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;c:\\Program Files\\Amazon\\cfn-bootstrap\\;c:\\Program Files (x86)\\Windows Kits\\8.0\\Windows Performance Toolkit\\;c:\\Program Files (x86)\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\Tools\\Binn\\;c:\\Program Files\\Microsoft SQL Server\\100\\DTS\\Binn\\;c:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;c:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;c:\\Program Files (x86)\\Microsoft SDKs\\TypeScript\\1.0\\;c:\\Program Files (x86)\\Puppet Labs\\Puppet\\bin;C:\\mozilla-build\\msys\\bin;c:\\mozilla-build\\python27\\scripts;c:\\mozilla-build\\wget;c:\\mozilla-build\\info-zip;c:\\mozilla-build;c:\\mozilla-build\\vim\\vim72;c:\\mozilla-build\\python27;c:\\mozilla-build\\hg;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:31:24 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:31:24 INFO - 'PDBSTR_PATH': '/c/Program Files (x86)/Windows Kits/8.0/Debuggers/x64/srcsrv/pdbstr.exe', 13:31:24 INFO - 'POST_UPLOAD_CMD': 'post_upload.py --tinderbox-builds-dir larch-win64 -p firefox -i 20161011124447 --revision 15a5f3920481be2c6cacf4938eedc28c77d37077 --release-to-tinderbox-dated-builds', 13:31:24 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:31:24 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 13:31:24 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel', 13:31:24 INFO - 'PROCESSOR_LEVEL': '6', 13:31:24 INFO - 'PROCESSOR_REVISION': '3f02', 13:31:24 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:31:24 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 13:31:24 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 13:31:24 INFO - 'PROGRAMW6432': 'C:\\Program Files', 13:31:24 INFO - 'PROMPT': '$P$G', 13:31:24 INFO - 'PROPERTIES_FILE': 'c:\\builds\\moz2_slave\\l-w64-000000000000000000000000\\buildprops.json', 13:31:24 INFO - 'PS1': '\\[\\033]0;$MSYSTEM:\\w\\007\n\\033[32m\\]\\u@\\h \\[\\033[33m\\w\\033[0m\\]\n$ ', 13:31:24 INFO - 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\;C:\\Program Files (x86)\\AWS Tools\\PowerShell\\', 13:31:24 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:31:24 INFO - 'PWD': 'c:/Users/cltbld', 13:31:24 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:31:24 INFO - 'SHELL': 'C:/mozilla-build/msys/bin/sh', 13:31:24 INFO - 'SHLVL': '1', 13:31:24 INFO - 'SSH_AGENT_PID': '3760', 13:31:24 INFO - 'SSH_AUTH_SOCK': 'C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656', 13:31:24 INFO - 'SYSTEMDRIVE': 'C:', 13:31:24 INFO - 'SYSTEMROOT': 'C:\\Windows', 13:31:24 INFO - 'TEMP': 'C:/Users/cltbld/AppData/Local/Temp', 13:31:24 INFO - 'TERM': 'cygwin', 13:31:24 INFO - 'TINDERBOX_OUTPUT': '1', 13:31:24 INFO - 'TMP': 'C:/Users/cltbld/AppData/Local/Temp', 13:31:24 INFO - 'TOOLTOOL_CACHE': '/c/builds/tooltool_cache', 13:31:24 INFO - 'TOOLTOOL_HOME': '/c/builds', 13:31:24 INFO - 'UPLOAD_HOST': 'upload.ffxbld.productdelivery.prod.mozaws.net', 13:31:24 INFO - 'UPLOAD_SSH_KEY': '/c/Users/cltbld/.ssh/ffxbld_rsa', 13:31:24 INFO - 'UPLOAD_TO_TEMP': '1', 13:31:24 INFO - 'UPLOAD_USER': 'ffxbld', 13:31:24 INFO - 'USERDOMAIN': 'B-2008-SPOT-106', 13:31:24 INFO - 'USERNAME': 'cltbld', 13:31:24 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:31:24 INFO - 'VS100COMNTOOLS': 'c:\\Program Files (x86)\\Microsoft Visual Studio 10.0\\Common7\\Tools\\', 13:31:24 INFO - 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 13:31:24 INFO - 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 13:31:24 INFO - 'WINDIR': 'C:\\Windows', 13:31:24 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:31:24 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:31:24 INFO - 'WIX_351728_PATH': 'c:/mozilla-build/wix-351728', 13:31:24 INFO - '_': 'C:\\mozilla-build\\buildbotve\\Scripts\\python'} 13:31:24 INFO - Calling ['c:\\mozilla-build\\python27\\python.exe', 'mach', '--log-no-times', 'build', '-v'] with output_timeout 4800 13:31:26 INFO - c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\mozmake.EXE -f client.mk -s configure 13:31:28 INFO - client.mk:202: c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/obj-firefox/.mozconfig.mk: No such file or directory 13:31:29 INFO - Clobber not needed. 13:31:31 INFO - Generating c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/configure 13:31:31 INFO - Generating c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/js/src/configure 13:31:31 INFO - cd c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/obj-firefox 13:31:31 INFO - c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/configure 13:31:32 INFO - Creating Python environment 13:31:38 INFO - New python executable in c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\obj-firefox\_virtualenv\Scripts\python2.7.exe 13:31:38 INFO - Also creating executable in c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\obj-firefox\_virtualenv\Scripts\python.exe 13:31:38 INFO - Installing setuptools, pip, wheel...done. 13:31:45 INFO - running build_ext 13:31:45 INFO - building 'psutil._psutil_windows' extension 13:31:45 INFO - creating build 13:31:45 INFO - creating build\temp.win32-2.7 13:31:45 INFO - creating build\temp.win32-2.7\Release 13:31:45 INFO - creating build\temp.win32-2.7\Release\psutil 13:31:45 INFO - creating build\temp.win32-2.7\Release\psutil\arch 13:31:45 INFO - creating build\temp.win32-2.7\Release\psutil\arch\windows 13:31:45 INFO - c:\Program Files (x86)\Microsoft Visual Studio 10.0\VC\BIN\cl.exe /c /nologo /Ox /MD /W3 /GS- /DNDEBUG -DPSUTIL_VERSION=311 -D_WIN32_WINNT=0x0601 -D_AVAIL_WINVER_=0x0601 -D_CRT_SECURE_NO_WARNINGS -DPSAPI_VERSION=1 -Ic:\mozilla-build\python27\include -Ic:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\obj-firefox\_virtualenv\PC /Tcpsutil/_psutil_windows.c /Fobuild\temp.win32-2.7\Release\psutil/_psutil_windows.obj 13:31:45 INFO - _psutil_windows.c 13:31:45 INFO - c:\Program Files (x86)\Microsoft Visual Studio 10.0\VC\BIN\cl.exe /c /nologo /Ox /MD /W3 /GS- /DNDEBUG -DPSUTIL_VERSION=311 -D_WIN32_WINNT=0x0601 -D_AVAIL_WINVER_=0x0601 -D_CRT_SECURE_NO_WARNINGS -DPSAPI_VERSION=1 -Ic:\mozilla-build\python27\include -Ic:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\obj-firefox\_virtualenv\PC /Tcpsutil/_psutil_common.c /Fobuild\temp.win32-2.7\Release\psutil/_psutil_common.obj 13:31:45 INFO - _psutil_common.c 13:31:45 INFO - c:\Program Files (x86)\Microsoft Visual Studio 10.0\VC\BIN\cl.exe /c /nologo /Ox /MD /W3 /GS- /DNDEBUG -DPSUTIL_VERSION=311 -D_WIN32_WINNT=0x0601 -D_AVAIL_WINVER_=0x0601 -D_CRT_SECURE_NO_WARNINGS -DPSAPI_VERSION=1 -Ic:\mozilla-build\python27\include -Ic:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\obj-firefox\_virtualenv\PC /Tcpsutil/arch/windows/process_info.c /Fobuild\temp.win32-2.7\Release\psutil/arch/windows/process_info.obj 13:31:45 INFO - process_info.c 13:31:45 INFO - c:\Program Files (x86)\Microsoft Visual Studio 10.0\VC\BIN\cl.exe /c /nologo /Ox /MD /W3 /GS- /DNDEBUG -DPSUTIL_VERSION=311 -D_WIN32_WINNT=0x0601 -D_AVAIL_WINVER_=0x0601 -D_CRT_SECURE_NO_WARNINGS -DPSAPI_VERSION=1 -Ic:\mozilla-build\python27\include -Ic:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\obj-firefox\_virtualenv\PC /Tcpsutil/arch/windows/process_handles.c /Fobuild\temp.win32-2.7\Release\psutil/arch/windows/process_handles.obj 13:31:45 INFO - process_handles.c 13:31:45 INFO - c:\Program Files (x86)\Microsoft Visual Studio 10.0\VC\BIN\cl.exe /c /nologo /Ox /MD /W3 /GS- /DNDEBUG -DPSUTIL_VERSION=311 -D_WIN32_WINNT=0x0601 -D_AVAIL_WINVER_=0x0601 -D_CRT_SECURE_NO_WARNINGS -DPSAPI_VERSION=1 -Ic:\mozilla-build\python27\include -Ic:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\obj-firefox\_virtualenv\PC /Tcpsutil/arch/windows/security.c /Fobuild\temp.win32-2.7\Release\psutil/arch/windows/security.obj 13:31:45 INFO - security.c 13:31:45 INFO - c:\Program Files (x86)\Microsoft Visual Studio 10.0\VC\BIN\cl.exe /c /nologo /Ox /MD /W3 /GS- /DNDEBUG -DPSUTIL_VERSION=311 -D_WIN32_WINNT=0x0601 -D_AVAIL_WINVER_=0x0601 -D_CRT_SECURE_NO_WARNINGS -DPSAPI_VERSION=1 -Ic:\mozilla-build\python27\include -Ic:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\obj-firefox\_virtualenv\PC /Tcpsutil/arch/windows/inet_ntop.c /Fobuild\temp.win32-2.7\Release\psutil/arch/windows/inet_ntop.obj 13:31:45 INFO - inet_ntop.c 13:31:45 INFO - creating build\lib.win32-2.7 13:31:45 INFO - creating build\lib.win32-2.7\psutil 13:31:45 INFO - c:\Program Files (x86)\Microsoft Visual Studio 10.0\VC\BIN\link.exe /DLL /nologo /INCREMENTAL:NO /LIBPATH:c:\mozilla-build\python27\Libs /LIBPATH:c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\obj-firefox\_virtualenv\libs /LIBPATH:c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\obj-firefox\_virtualenv\PCbuild psapi.lib kernel32.lib advapi32.lib shell32.lib netapi32.lib iphlpapi.lib wtsapi32.lib ws2_32.lib /EXPORT:init_psutil_windows build\temp.win32-2.7\Release\psutil/_psutil_windows.obj build\temp.win32-2.7\Release\psutil/_psutil_common.obj build\temp.win32-2.7\Release\psutil/arch/windows/process_info.obj build\temp.win32-2.7\Release\psutil/arch/windows/process_handles.obj build\temp.win32-2.7\Release\psutil/arch/windows/security.obj build\temp.win32-2.7\Release\psutil/arch/windows/inet_ntop.obj /OUT:build\lib.win32-2.7\psutil\_psutil_windows.pyd /IMPLIB:build\temp.win32-2.7\Release\psutil\_psutil_windows.lib /MANIFESTFILE:build\temp.win32-2.7\Release\psutil\_psutil_windows.pyd.manifest 13:31:45 INFO - Creating library build\temp.win32-2.7\Release\psutil\_psutil_windows.lib and object build\temp.win32-2.7\Release\psutil\_psutil_windows.exp 13:31:45 INFO - copying build\lib.win32-2.7\psutil\_psutil_windows.pyd -> psutil 13:31:45 INFO - c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\python\mozbuild\mozbuild\virtualenv.py:376: UserWarning: Hacking environment to allow binary Python extensions to build. You can make this warning go away by installing Visual Studio 2008. You can download the Express Edition installer from http://go.microsoft.com/?linkid=7729279 13:31:45 INFO - warnings.warn('Hacking environment to allow binary Python ' 13:31:45 INFO - Reexecuting in the virtualenv 13:31:46 INFO - Adding configure options from c:\builds\moz2_slave\l-w64-000000000000000000000000\build\src\.mozconfig 13:31:46 INFO - --target=x86_64-pc-mingw32 13:31:46 INFO - --host=x86_64-pc-mingw32 13:31:46 INFO - --enable-crashreporter 13:31:46 INFO - --enable-release 13:31:46 INFO - --enable-js-shell 13:31:46 INFO - --enable-update-channel= 13:31:46 INFO - --enable-jemalloc 13:31:46 INFO - --with-google-api-keyfile=/c/builds/gapi.data 13:31:46 INFO - --with-mozilla-api-keyfile=/c/builds/mozilla-desktop-geoloc-api.key 13:31:46 INFO - --enable-eme=+adobe 13:31:46 INFO - --enable-profiling 13:31:46 INFO - --enable-verify-mar 13:31:46 INFO - --with-branding=browser/branding/nightly 13:31:46 INFO - --enable-rust 13:31:46 INFO - MOZ_PACKAGE_JSSHELL=1 13:31:46 INFO - MOZILLA_OFFICIAL=1 13:31:46 INFO - MOZ_TELEMETRY_REPORTING=1 13:31:46 INFO - SOCORRO_SYMBOL_UPLOAD_TOKEN_FILE=c:/builds/crash-stats-api.token 13:31:46 INFO - PATH=/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/bin/x64:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/redist/x64/Microsoft.VC140.CRT:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/Redist/ucrt/DLLs/x64:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/DIA SDK/bin/amd64:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/bin/x64:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/redist/x64/Microsoft.VC140.CRT:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/Redist/ucrt/DLLs/x64:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/DIA SDK/bin/amd64:/c/mozilla-build/nsis-3.0b1:/c/mozilla-build/python27:/c/mozilla-build/buildbotve/scripts:/c/mozilla-build/nsis-3.0b1:/c/mozilla-build/nsis-2.46u:/c/mozilla-build/python27:/c/mozilla-build/buildbotve/scripts:/usr/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:.:/usr/local/bin:/usr/mingw/bin:/usr/bin:/c/Program Files (x86)/Puppet Labs/Puppet/puppet/bin:/c/Program Files (x86)/Puppet Labs/Puppet/facter/bin:/c/Program Files (x86)/Puppet Labs/Puppet/hiera/bin:/c/Program Files (x86)/Puppet Labs/Puppet/bin:/c/Program Files (x86)/Puppet Labs/Puppet/sys/ruby/bin:/c/Program Files (x86)/Puppet Labs/Puppet/sys/tools/bin:/c/Windows/system32:/c/Windows:/c/Windows/System32/Wbem:/c/Windows/System32/WindowsPowerShell/v1.0/:/c/Program Files/Amazon/cfn-bootstrap/:/c/Program Files (x86)/Windows Kits/8.0/Windows Performance Toolkit/:/c/Program Files (x86)/Microsoft SQL Server/100/Tools/Binn/:/c/Program Files/Microsoft SQL Server/100/Tools/Binn/:/c/Program Files/Microsoft SQL Server/100/DTS/Binn/:/c/Program Files (x86)/Windows Kits/8.1/Windows Performance Toolkit/:/c/Program Files/Microsoft SQL Server/110/Tools/Binn/:/c/Program Files (x86)/Microsoft SDKs/TypeScript/1.0/:/c/Program Files (x86)/Puppet Labs/Puppet/bin:/usr/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/hg:/c/mozilla-build/buildbotve/Scripts:/c/ProgramData/chocolatey/bin:.:/c/opt/runner:/c/mozilla-build/buildbotve:/c/mozilla-build/python27:/usr/mingw/bin:/usr/bin:/usr/local/bin:.:/usr/local/bin:/c/mozilla-build/moztools-x64/bin:/c/mozilla-build/vim/vim72 13:31:46 INFO - WIN_UCRT_REDIST_DIR=/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/Redist/ucrt/DLLs/x64 13:31:46 INFO - INCLUDE=/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/include:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/atlmfc/include:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/Include/10.0.14393.0/ucrt:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/Include/10.0.14393.0/shared:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/Include/10.0.14393.0/um:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/Include/10.0.14393.0/winrt:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/DIA SDK/include 13:31:46 INFO - LIB=/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/lib/amd64:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/atlmfc/lib/amd64:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/lib/10.0.14393.0/ucrt/x64:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/lib/10.0.14393.0/um/x64:/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/DIA SDK/lib/amd64 13:31:46 INFO - WIN32_REDIST_DIR=/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/redist/x64/Microsoft.VC140.CRT 13:31:46 INFO - CARGO=c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/cargo/bin/cargo 13:31:46 INFO - MOZ_ADDON_SIGNING=1 13:31:46 INFO - MOZ_REQUIRE_SIGNING=0 13:31:46 INFO - VSPATH=/c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3 13:31:46 INFO - TOOLTOOL_DIR=c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src 13:31:46 INFO - VSWINPATH=c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3 13:31:46 INFO - RUSTC=c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/rustc/bin/rustc 13:31:46 INFO - checking for a shell... C:/mozilla-build/msys/bin/sh.exe 13:31:46 INFO - checking for host system type... x86_64-pc-mingw32 13:31:46 INFO - checking for target system type... x86_64-pc-mingw32 13:31:46 INFO - checking whether cross compiling... no 13:31:46 INFO - checking for pkg_config... not found 13:31:46 INFO - checking for yasm... c:/mozilla-build/yasm/yasm.EXE 13:31:46 INFO - checking yasm version... 1.3.0 13:31:46 INFO - checking for the target C compiler... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE 13:31:46 INFO - checking whether the target C compiler can be used... yes 13:31:46 INFO - checking the target C compiler version... 19.00.24213 13:31:46 INFO - checking the target C compiler works... yes 13:31:46 INFO - checking for the target C++ compiler... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE 13:31:46 INFO - checking whether the target C++ compiler can be used... yes 13:31:46 INFO - checking the target C++ compiler version... 19.00.24213 13:31:46 INFO - checking the target C++ compiler works... yes 13:31:46 INFO - checking for the host C compiler... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE 13:31:46 INFO - checking whether the host C compiler can be used... yes 13:31:46 INFO - checking the host C compiler version... 19.00.24213 13:31:46 INFO - checking the host C compiler works... yes 13:31:46 INFO - checking for the host C++ compiler... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE 13:31:46 INFO - checking whether the host C++ compiler can be used... yes 13:31:46 INFO - checking the host C++ compiler version... 19.00.24213 13:31:47 INFO - checking the host C++ compiler works... yes 13:31:47 INFO - checking for 64-bit OS... yes 13:31:47 INFO - checking for Windows SDK... 0x0a00 in c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK 13:31:47 INFO - checking for Universal CRT SDK... 10.0.14393.0 in c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK 13:31:47 INFO - checking for the Debug Interface Access SDK... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/DIA SDK 13:31:47 INFO - checking for mt... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/bin/x64/mt.exe 13:31:47 INFO - checking whether MT is really Microsoft Manifest Tool... yes 13:31:47 INFO - checking for link... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/link.exe 13:31:47 INFO - checking for rustc... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/rustc/bin/rustc.EXE 13:31:47 INFO - checking for cargo... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/cargo/bin/cargo.EXE 13:31:47 INFO - checking rustc version... 1.11.0 13:31:47 INFO - checking cargo support for --frozen... yes 13:31:47 INFO - checking for stdint.h... yes 13:31:47 INFO - checking for inttypes.h... yes 13:31:47 INFO - checking for malloc.h... yes 13:31:47 INFO - checking for alloca.h... no 13:31:47 INFO - checking for perf_event_open system call... no 13:31:47 INFO - checking for tar... C:/mozilla-build/msys/bin/tar.EXE 13:31:47 INFO - checking for unzip... c:/mozilla-build/info-zip/unzip.EXE 13:31:47 INFO - checking for zip... c:/mozilla-build/info-zip/zip.EXE 13:31:47 INFO - checking for the Mozilla API key... no 13:31:47 INFO - checking for the Google API key... no 13:31:47 INFO - checking for the Bing API key... no 13:31:47 INFO - checking for the Adjust SDK key... no 13:31:47 INFO - checking for awk... C:/mozilla-build/msys/bin/gawk.EXE 13:31:47 INFO - checking for perl... C:/mozilla-build/msys/bin/perl.EXE 13:31:47 INFO - checking for minimum required perl version >= 5.006... 5.006001 13:31:48 INFO - checking for full perl installation... yes 13:31:48 INFO - checking for gmake... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/mozmake.EXE 13:31:48 INFO - checking for doxygen... not found 13:31:48 INFO - checking for xargs... C:/mozilla-build/msys/bin/xargs.EXE 13:31:48 INFO - checking for makensisu... c:/mozilla-build/nsis-3.0b1/makensis-3.0b1.exe 13:31:48 INFO - checking for NSIS version... 3.0b1 13:31:48 INFO - checking for 32-bit NSIS... yes 13:31:48 INFO - checking for autoconf... C:/mozilla-build/msys/local/bin/autoconf-2.13 13:31:48 INFO - Refreshing c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/old-configure with C:/mozilla-build/msys/local/bin/autoconf-2.13 13:31:51 INFO - creating cache ./config.cache 13:31:51 INFO - checking host system type... x86_64-pc-mingw32 13:31:51 INFO - checking target system type... x86_64-pc-mingw32 13:31:51 INFO - checking build system type... x86_64-pc-mingw32 13:31:52 INFO - checking for gcc... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE 13:31:52 INFO - checking whether the C compiler (c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE ) works... yes 13:31:52 INFO - checking whether the C compiler (c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE ) is a cross-compiler... no 13:31:52 INFO - checking whether we are using GNU C... no 13:31:52 INFO - checking whether c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE accepts -g... no 13:31:54 INFO - checking for c++... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE 13:31:54 INFO - checking whether the C++ compiler (c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE ) works... yes 13:31:54 INFO - checking whether the C++ compiler (c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE ) is a cross-compiler... no 13:31:54 INFO - checking whether we are using GNU C++... no 13:31:54 INFO - checking whether c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/cl.EXE accepts -g... no 13:31:54 INFO - checking for ranlib... : 13:31:54 INFO - checking for ml64... /c/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/ml64 13:31:54 INFO - checking for ar... no 13:31:54 INFO - checking for ld... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/VC/bin/amd64/link.exe 13:31:54 INFO - checking for strip... no 13:31:54 INFO - checking for windres... no 13:31:54 INFO - checking for otool... no 13:31:54 INFO - checking for midl... midl 13:31:55 INFO - checking for dia2.h... yes 13:31:56 INFO - checking for overridable _RAISE... yes 13:31:56 INFO - checking for X... no 13:31:57 INFO - checking for malloc.h... yes 13:31:58 INFO - checking for strndup... no 13:31:58 INFO - checking for posix_memalign... no 13:31:58 INFO - checking for memalign... no 13:31:58 INFO - checking for malloc_usable_size... no 13:31:58 INFO - checking whether malloc_usable_size definition can use const argument... yes 13:31:58 INFO - checking for valloc in malloc.h... no 13:31:58 INFO - checking for valloc in unistd.h... no 13:31:58 INFO - checking NSPR selection... source-tree 13:31:59 INFO - checking if app-specific confvars.sh exists... c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/browser/confvars.sh 13:32:00 INFO - Found D3D compiler in Windows SDK. 13:32:00 INFO - Found MOZ_D3DCOMPILER_VISTA_DLL_PATH: c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/vs2015u3/SDK/Redist/D3D/x64/d3dcompiler_47.dll 13:32:00 INFO - We are building a 64-bit binary, skip checking d3dcompiler_43. 13:32:00 INFO - Found d3dcompiler DLL for Vista+: d3dcompiler_47.dll 13:32:00 INFO - checking for wget... wget 13:32:00 INFO - checking for valid C compiler optimization flags... yes 13:32:01 INFO - checking what kind of list files are supported by the linker... list 13:32:01 INFO - checking for d3d9.h... yes 13:32:02 INFO - checking for d3d10.h... yes 13:32:03 INFO - checking for posix_fadvise... no 13:32:03 INFO - checking for posix_fallocate... no 13:32:03 INFO - c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/old-configure: line 19742: syntax error near unexpected token `<<<' 13:32:03 INFO - c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/old-configure: line 19742: `<<<<<<< local' 13:32:03 INFO - DEBUG: 13:32:03 INFO - DEBUG: #define posix_fallocate innocuous_posix_fallocate 13:32:03 INFO - DEBUG: #include 13:32:03 INFO - DEBUG: #undef posix_fallocate 13:32:03 INFO - DEBUG: /* Override any gcc2 internal prototype to avoid an error. */ 13:32:03 INFO - DEBUG: /* We use char because int might match the return type of a gcc2 13:32:03 INFO - DEBUG: builtin and then its argument prototype would still apply. */ 13:32:03 INFO - DEBUG: char posix_fallocate(); 13:32:03 INFO - DEBUG: 13:32:03 INFO - DEBUG: int main() { 13:32:03 INFO - DEBUG: 13:32:03 INFO - DEBUG: /* The GNU C library defines this for functions which it implements 13:32:03 INFO - DEBUG: to always fail with ENOSYS. Some functions are actually named 13:32:03 INFO - DEBUG: something starting with __ and the normal name is an alias. */ 13:32:03 INFO - DEBUG: #if defined (__stub_posix_fallocate) || defined (__stub___posix_fallocate) 13:32:03 INFO - DEBUG: choke me 13:32:03 INFO - DEBUG: #else 13:32:03 INFO - DEBUG: posix_fallocate(); 13:32:03 INFO - DEBUG: #endif 13:32:03 INFO - DEBUG: 13:32:03 INFO - DEBUG: ; return 0; } 13:32:03 INFO - ERROR: old-configure failed 13:32:03 INFO - *** Fix above errors and then restart with\ 13:32:03 INFO - "c:/builds/moz2_slave/l-w64-000000000000000000000000/build/src/mozmake.EXE -f client.mk build" 13:32:03 INFO - client.mk:373: recipe for target 'configure' failed 13:32:03 INFO - mozmake.EXE: *** [configure] Error 1 14:52:03 INFO - Automation Error: mozprocess timed out after 4800 seconds running ['c:\\mozilla-build\\python27\\python.exe', 'mach', '--log-no-times', 'build', '-v'] 14:52:03 ERROR - timed out after 4800 seconds of no output 14:52:03 ERROR - Return code: 572 14:52:03 WARNING - setting return code to 2 14:52:03 FATAL - 'mach build' did not run successfully. Please check log for errors. 14:52:03 FATAL - Running post_fatal callback... 14:52:03 FATAL - Exiting -1 14:52:03 INFO - Running post-action listener: influxdb_recording_post_action 14:52:03 INFO - Resetting dropped connection: goldiewilson-onepointtwentyone-1.c.influxdb.com c:\builds\moz2_slave\l-w64-000000000000000000000000\build\venv\Lib\site-packages\requests\packages\urllib3\util\ssl_.py:90: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. For more information, see https://urllib3.readthedocs.org/en/latest/security.html#insecureplatformwarning. InsecurePlatformWarning 14:52:03 INFO - Running post-action listener: record_mach_stats 14:52:03 INFO - No build_resources.json found, not logging stats 14:52:03 INFO - [mozharness: 2016-10-11 21:52:03.540000Z] Finished build step (failed) 14:52:03 INFO - Running post-run listener: _summarize 14:52:03 ERROR - # TBPL FAILURE # 14:52:03 INFO - [mozharness: 2016-10-11 21:52:03.541000Z] FxDesktopBuild summary: 14:52:03 ERROR - # TBPL FAILURE # 14:52:03 INFO - Running post-run listener: copy_logs_to_upload_dir 14:52:03 INFO - Copying logs to upload dir... 14:52:03 INFO - mkdir: c:\builds\moz2_slave\l-w64-000000000000000000000000\build\upload\logs program finished with exit code -1 elapsedTime=6228.683000 ========= master_lag: 0.03 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 1 hrs, 43 mins, 48 secs) (at 2016-10-11 14:52:05.228914) ========= ========= Started set props: buildid got_revision comments builduid stage_platform (results: 0, elapsed: 0 secs) (at 2016-10-11 14:52:05.232108) ========= 'bash' '-c' 'for file in `ls -1`; do cat $file; done' in dir c:\builds\moz2_slave\l-w64-000000000000000000000000\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-106 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-106 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=8 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\hg;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=3760 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656 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-106 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:20161011124447 builduid:24735c14cd0c41d2856c32aa24e48f22 comments:Merge m-c into larch got_revision:15a5f3920481 stage_platform:win64 program finished with exit code 0 elapsedTime=0.109000 buildid: '20161011124447' got_revision: '15a5f3920481' comments: 'Merge m-c into larch' builduid: '24735c14cd0c41d2856c32aa24e48f22' stage_platform: 'win64' ========= master_lag: 0.02 ========= ========= Finished set props: buildid got_revision comments builduid stage_platform (results: 0, elapsed: 0 secs) (at 2016-10-11 14:52:05.363647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:52:05.364624) ========= 'rm' '-f' 'oauth.txt' in dir c:\builds\moz2_slave\l-w64-000000000000000000000000\. (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-106 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-106 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=8 OLDPWD=c:/Users/cltbld OS=Windows_NT OSTYPE=msys OS_VERSION=2008 PATH=C:\mozilla-build\msys\local\bin;c:\mozilla-build\wget;c:\mozilla-build\7zip;c:\mozilla-build\blat261\full;c:\mozilla-build\python;c:\mozilla-build\svn-win32-1.6.3\bin;c:\mozilla-build\upx203w;c:\mozilla-build\emacs-24.3\bin;c:\mozilla-build\info-zip;c:\mozilla-build\nsis-2.46u;c:\mozilla-build\nsis-3.0a2;c:\mozilla-build\wix-351728;c:\mozilla-build\hg;c:\mozilla-build\python\Scripts;c:\mozilla-build\kdiff3;c:\mozilla-build\yasm;c:\mozilla-build\mozmake;.;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\msys\bin;c:\Program Files (x86)\Puppet Labs\Puppet\puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\facter\bin;c:\Program Files (x86)\Puppet Labs\Puppet\hiera\bin;c:\Program Files (x86)\Puppet Labs\Puppet\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;c:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;c:\Windows\system32;c:\Windows;c:\Windows\System32\Wbem;c:\Windows\System32\WindowsPowerShell\v1.0\;c:\Program Files\Amazon\cfn-bootstrap\;c:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;c:\Program Files\Microsoft SQL Server\110\Tools\Binn\;c:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;c:\Program Files (x86)\Puppet Labs\Puppet\bin;C:\mozilla-build\msys\bin;c:\mozilla-build\python27\scripts;c:\mozilla-build\wget;c:\mozilla-build\info-zip;c:\mozilla-build;c:\mozilla-build\vim\vim72;c:\mozilla-build\python27;c:\mozilla-build\hg;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=3760 SSH_AUTH_SOCK=C:/Users/cltbld/AppData/Local/Temp/ssh-aLzCGr3656/agent.3656 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-106 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 2016-10-11 14:52:05.476495) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 14:52:05.477456) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 14:52:05.477842) ========= ========= Total master_lag: 0.25 =========