builder: mozilla-inbound_win7_vm_gfx-debug_test-mochitest-gl-2
slave: g-w732-spot-156
starttime: 1497306519.03
results: warnings (1)
buildid: 20170612135334
builduid: 1303958dc1aa46cbb329d82e162a1886
revision: c38ea3bf870496afac1a17646e45a733f718abc6

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:39.026617) =========
master: http://buildbot-master129.bb.releng.usw2.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:39.027245) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:39.027714) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:39.073152) =========

========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-06-12 15:28:39.073641) =========
'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:\slave\test\. (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
  BUILDBOT_PATH=C:\mozilla-build\
  CHOCOLATEYINSTALL=C:\ProgramData\chocolatey
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=G-W732-SPOT-156
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  IDLEIZER_HALT_ON_IDLE=true
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOG="c:\runner\buildbot-startup.log"
  LOGONSERVER=\\G-W732-SPOT-156
  MAKE_MODE=unix
  MOZBUILDDIR=C:\mozilla-build
  MOZILLABUILD=C:\mozilla-build
  MOZ_TOOLS=C:\mozilla-build\moztools
  MSYSTEM=MINGW32
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;C:\Program Files (x86)\Puppet Labs\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\puppet\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;C:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;C:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;C:\Program Files\Amazon\cfn-bootstrap\;C:\Program Files\Microsoft SQL Server\110\Tools\Binn\;C:\mozilla-build\buildbotve;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\python27;C:\opt\runner;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn;C:\Users\cltbld\AppData\Local\Programs\Common\Microsoft\Visual C++ for Python\9.0;;C:\mozilla-build\moztools\bin
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 62 Stepping 4, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3e04
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files\AWS Tools\PowerShell\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=G-W732-SPOT-156
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
--15:28:37--  https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
           => `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:443... connected.
WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,179 (12K) [text/x-python]

    0K .......... .                                          100%   14.68 MB/s

15:28:37 (14.68 MB/s) - `archiver_client.py' saved [12179/12179]

program finished with exit code 0
elapsedTime=0.327000
========= master_lag: 3.45 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-06-12 15:28:42.851602) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2017-06-12 15:28:42.852402) =========
'rm' '-rf' 'scripts' 'properties'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'scripts', 'properties']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  BUILDBOT_PATH=C:\mozilla-build\
  CHOCOLATEYINSTALL=C:\ProgramData\chocolatey
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=G-W732-SPOT-156
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  IDLEIZER_HALT_ON_IDLE=true
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOG="c:\runner\buildbot-startup.log"
  LOGONSERVER=\\G-W732-SPOT-156
  MAKE_MODE=unix
  MOZBUILDDIR=C:\mozilla-build
  MOZILLABUILD=C:\mozilla-build
  MOZ_TOOLS=C:\mozilla-build\moztools
  MSYSTEM=MINGW32
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;C:\Program Files (x86)\Puppet Labs\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\puppet\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;C:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;C:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;C:\Program Files\Amazon\cfn-bootstrap\;C:\Program Files\Microsoft SQL Server\110\Tools\Binn\;C:\mozilla-build\buildbotve;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\python27;C:\opt\runner;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn;C:\Users\cltbld\AppData\Local\Programs\Common\Microsoft\Visual C++ for Python\9.0;;C:\mozilla-build\moztools\bin
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 62 Stepping 4, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3e04
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files\AWS Tools\PowerShell\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=G-W732-SPOT-156
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
program finished with exit code 0
elapsedTime=2.101000
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2017-06-12 15:28:44.992813) =========

========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-06-12 15:28:44.993393) =========
15:28:38     INFO - GECKO(1168) | MEMORY STAT | vsize 1153MB | vsizeMaxContiguous 322MB | residentFast 408MB | heapAllocated 293MB
15:28:38     INFO - TEST-OK | dom/canvas/test/webgl-conf/generated/test_2_conformance__ogles__GL__cos__cos_001_to_006.html | took 3116ms
15:28:38     INFO - GECKO(1168) | ++DOMWINDOW == 44 (19327400) [pid = 1168] [serial = 2455] [outer = 17F06000]
15:28:38     INFO - TEST-START | dom/canvas/test/webgl-conf/generated/test_2_conformance__ogles__GL__cross__cross_001_to_002.html
15:28:38     INFO - GECKO(1168) | ++DOMWINDOW == 45 (15C79800) [pid = 1168] [serial = 2456] [outer = 17F06000]
15:28:38     INFO - GECKO(1168) | --DOCSHELL 15D91800 == 10 [pid = 1168] [id = {84cafdcb-5a47-4d97-b917-0942610b49f0}]
15:28:38     INFO - GECKO(1168) | --DOCSHELL 1E07C000 == 9 [pid = 1168] [id = {20ed1a30-3d52-48c5-8823-dd13f9f4d6c2}]
15:28:38     INFO - GECKO(1168) | --DOCSHELL 1C17AC00 == 8 [pid = 1168] [id = {18e09734-6377-4b25-af14-a2319e124ce9}]
15:28:38     INFO - GECKO(1168) | --DOCSHELL 1932D000 == 7 [pid = 1168] [id = {e0a23206-40e2-4eb1-86e9-a0628540cb00}]
15:28:38     INFO - GECKO(1168) | --DOCSHELL 19366400 == 6 [pid = 1168] [id = {0a29b95c-b8e3-412b-9bba-2ee5a2156493}]
15:28:38     INFO - GECKO(1168) | ++DOCSHELL 15BA6C00 == 7 [pid = 1168] [id = {3687fcc2-00b6-49ea-ad9d-dfe551d1cbca}]
15:28:38     INFO - GECKO(1168) | ++DOMWINDOW == 46 (15BA7800) [pid = 1168] [serial = 2457] [outer = 00000000]
15:28:39     INFO - GECKO(1168) | ++DOMWINDOW == 47 (15C71C00) [pid = 1168] [serial = 2458] [outer = 15BA7800]
15:28:39     INFO - GECKO(1168) | ++DOCSHELL 15D69C00 == 8 [pid = 1168] [id = {d543492f-32bb-474f-8284-8649bf4e1a9d}]
15:28:39     INFO - GECKO(1168) | ++DOMWINDOW == 48 (15D71C00) [pid = 1168] [serial = 2459] [outer = 00000000]
15:28:39     INFO - GECKO(1168) | ++DOMWINDOW == 49 (15C70C00) [pid = 1168] [serial = 2460] [outer = 15D71C00]
15:28:39     INFO - GECKO(1168) | --DOMWINDOW == 48 (15B9F800) [pid = 1168] [serial = 2432] [outer = 00000000] [url = about:blank]
15:28:39     INFO - GECKO(1168) | --DOMWINDOW == 47 (1CE3D400) [pid = 1168] [serial = 2423] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance/ogles/GL/ceil/ceil_001_to_006.html?webglVersion=2]
15:28:39     INFO - GECKO(1168) | --DOMWINDOW == 46 (1E7DAC00) [pid = 1168] [serial = 2426] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance/ogles/GL/ceil/ceil_001_to_006.html?webglVersion=2]
15:28:39     INFO - GECKO(1168) | --DOMWINDOW == 45 (21638800) [pid = 1168] [serial = 2427] [outer = 00000000] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
15:28:39     INFO - GECKO(1168) | Destroying context 21D2D800 surface 17BC0300 on display 183897D0
15:28:39     INFO - GECKO(1168) | ++DOMWINDOW == 46 (09E06800) [pid = 1168] [serial = 2461] [outer = 15D71C00]
15:28:39     INFO - GECKO(1168) | Initializing context 1DC80800 surface 17B3F200 on display 183897D0
15:28:40     INFO - GECKO(1168) | MEMORY STAT | vsize 1144MB | vsizeMaxContiguous 322MB | residentFast 364MB | heapAllocated 244MB
15:28:40     INFO - TEST-OK | dom/canvas/test/webgl-conf/generated/test_2_conformance__ogles__GL__cross__cross_001_to_002.html | took 2261ms
15:28:40     INFO - GECKO(1168) | ++DOMWINDOW == 47 (15D9B800) [pid = 1168] [serial = 2462] [outer = 17F06000]
15:28:40     INFO - TEST-START | dom/canvas/test/webgl-conf/generated/test_2_conformance__ogles__GL__default__default_001_to_001.html
15:28:40     INFO - GECKO(1168) | ++DOMWINDOW == 48 (15B42000) [pid = 1168] [serial = 2463] [outer = 17F06000]
15:28:40     INFO - GECKO(1168) | ++DOCSHELL 15D6BC00 == 9 [pid = 1168] [id = {bbeeb830-d253-40d0-bc86-e418e1fef09d}]
15:28:40     INFO - GECKO(1168) | ++DOMWINDOW == 49 (15D6FC00) [pid = 1168] [serial = 2464] [outer = 00000000]
15:28:40     INFO - GECKO(1168) | ++DOMWINDOW == 50 (15DE3800) [pid = 1168] [serial = 2465] [outer = 15D6FC00]
15:28:40     INFO - GECKO(1168) | ++DOCSHELL 17D26400 == 10 [pid = 1168] [id = {a49a15e6-deed-4727-8b37-c913406a71ac}]
15:28:40     INFO - GECKO(1168) | ++DOMWINDOW == 51 (17D26C00) [pid = 1168] [serial = 2466] [outer = 00000000]
15:28:40     INFO - GECKO(1168) | ++DOMWINDOW == 52 (17792000) [pid = 1168] [serial = 2467] [outer = 17D26C00]
15:28:41     INFO - GECKO(1168) | ++DOMWINDOW == 53 (15D95800) [pid = 1168] [serial = 2468] [outer = 17D26C00]
15:28:41     INFO - GECKO(1168) | Initializing context 21D2C800 surface 17E16180 on display 183897D0
15:28:42     INFO - GECKO(1168) | MEMORY STAT | vsize 1146MB | vsizeMaxContiguous 322MB | residentFast 373MB | heapAllocated 254MB
15:28:42     INFO - TEST-OK | dom/canvas/test/webgl-conf/generated/test_2_conformance__ogles__GL__default__default_001_to_001.html | took 1688ms
15:28:42     INFO - GECKO(1168) | ++DOMWINDOW == 54 (17F0EC00) [pid = 1168] [serial = 2469] [outer = 17F06000]
15:28:42     INFO - TEST-START | dom/canvas/test/webgl-conf/generated/test_2_conformance__ogles__GL__degrees__degrees_001_to_006.html
15:28:42     INFO - GECKO(1168) | --DOMWINDOW == 53 (1938F800) [pid = 1168] [serial = 2445] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance/ogles/GL/control_flow/control_flow_009_to_010.html?webglVersion=2]
15:28:42     INFO - GECKO(1168) | --DOMWINDOW == 52 (1932D800) [pid = 1168] [serial = 2443] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance/ogles/GL/control_flow/control_flow_009_to_010.html?webglVersion=2]
15:28:42     INFO - GECKO(1168) | --DOMWINDOW == 51 (15D91C00) [pid = 1168] [serial = 2438] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance/ogles/GL/control_flow/control_flow_001_to_008.html?webglVersion=2]
15:28:42     INFO - GECKO(1168) | --DOMWINDOW == 50 (1C17B000) [pid = 1168] [serial = 2436] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance/ogles/GL/control_flow/control_flow_001_to_008.html?webglVersion=2]
15:28:42     INFO - GECKO(1168) | --DOMWINDOW == 49 (15B9D400) [pid = 1168] [serial = 2429] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance/ogles/GL/clamp/clamp_001_to_006.html?webglVersion=2]
15:28:42     INFO - GECKO(1168) | --DOMWINDOW == 48 (15BA3400) [pid = 1168] [serial = 2431] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance/ogles/GL/clamp/clamp_001_to_006.html?webglVersion=2]
15:28:42     INFO - GECKO(1168) | ++DOMWINDOW == 49 (15B9D400) [pid = 1168] [serial = 2470] [outer = 17F06000]
15:28:42     INFO - GECKO(1168) | ++DOCSHELL 17C53800 == 11 [pid = 1168] [id = {6e178301-97e4-43e1-84f5-7f040d8dc77e}]
15:28:42     INFO - GECKO(1168) | ++DOMWINDOW == 50 (17DB0800) [pid = 1168] [serial = 2471] [outer = 00000000]
15:28:42     INFO - GECKO(1168) | ++DOMWINDOW == 51 (17F0C400) [pid = 1168] [serial = 2472] [outer = 17DB0800]
15:28:42     INFO - GECKO(1168) | ++DOCSHELL 1C2F2000 == 12 [pid = 1168] [id = {0ed22304-04ba-4b5f-954e-535fc1c9bf44}]
15:28:42     INFO - GECKO(1168) | ++DOMWINDOW == 52 (1CE37C00) [pid = 1168] [serial = 2473] [outer = 00000000]
15:28:42     INFO - GECKO(1168) | ++DOMWINDOW == 53 (1938B400) [pid = 1168] [serial = 2474] [outer = 1CE37C00]
15:28:42     INFO - GECKO(1168) | ++DOMWINDOW == 54 (15DE4000) [pid = 1168] [serial = 2475] [outer = 1CE37C00]
15:28:42     INFO - GECKO(1168) | Initializing context 23A78000 surface 17DF8700 on display 183897D0
'bash' '-c' u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c38ea3bf870496afac1a17646e45a733f718abc6 --destination scripts --debug'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c38ea3bf870496afac1a17646e45a733f718abc6 --destination scripts --debug']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  BUILDBOT_PATH=C:\mozilla-build\
  CHOCOLATEYINSTALL=C:\ProgramData\chocolatey
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=G-W732-SPOT-156
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  IDLEIZER_HALT_ON_IDLE=true
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOG="c:\runner\buildbot-startup.log"
  LOGONSERVER=\\G-W732-SPOT-156
  MAKE_MODE=unix
  MOZBUILDDIR=C:\mozilla-build
  MOZILLABUILD=C:\mozilla-build
  MOZ_TOOLS=C:\mozilla-build\moztools
  MSYSTEM=MINGW32
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;C:\Program Files (x86)\Puppet Labs\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\puppet\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;C:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;C:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;C:\Program Files\Amazon\cfn-bootstrap\;C:\Program Files\Microsoft SQL Server\110\Tools\Binn\;C:\mozilla-build\buildbotve;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\python27;C:\opt\runner;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn;C:\Users\cltbld\AppData\Local\Programs\Common\Microsoft\Visual C++ for Python\9.0;;C:\mozilla-build\moztools\bin
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 62 Stepping 4, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3e04
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files\AWS Tools\PowerShell\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=G-W732-SPOT-156
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
2017-06-12 15:28:43,338 truncating revision to first 12 chars
2017-06-12 15:28:43,338 Setting DEBUG logging.
2017-06-12 15:28:43,338 attempt 1/10
2017-06-12 15:28:43,338 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c38ea3bf8704?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-06-12 15:28:45,000 unpacking tar archive at: mozilla-inbound-c38ea3bf8704/testing/mozharness/
2017-06-12 15:28:45,301 skipping symlink on windows: configs/single_locale/linux32.py
2017-06-12 15:28:45,302 skipping symlink on windows: configs/single_locale/linux32_devedition.py
program finished with exit code 0
elapsedTime=2.416000
========= master_lag: 0.17 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-06-12 15:28:47.579988) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:47.580790) =========
script_repo_revision: c38ea3bf870496afac1a17646e45a733f718abc6
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:47.581829) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:47.582410) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:47.591793) =========

========= Started 'c:/mozilla-build/python27/python -u ...' warnings (results: 1, elapsed: 0 secs) (at 2017-06-12 15:28:47.592076) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/desktop_unittest.py' '--cfg' 'unittests/win_unittest.py' '--mochitest-suite' 'mochitest-gl' '--total-chunks' '3' '--this-chunk' '2' '--blob-upload-branch' 'mozilla-inbound' '--download-symbols' 'true'
 in dir C:\slave\test\. (timeout 1800 secs) (maxTime 5400 secs)
 watching logfiles {}
 argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/desktop_unittest.py', '--cfg', 'unittests/win_unittest.py', '--mochitest-suite', 'mochitest-gl', '--total-chunks', '3', '--this-chunk', '2', '--blob-upload-branch', 'mozilla-inbound', '--download-symbols', 'true']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  BUILDBOT_PATH=C:\mozilla-build\
  CHOCOLATEYINSTALL=C:\ProgramData\chocolatey
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=G-W732-SPOT-156
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  DevEnvDir=D:\msvs8\Common7\IDE
  FP_NO_HOST_CHECK=NO
  FrameworkDir=C:\WINDOWS\Microsoft.NET\Framework
  FrameworkSDKDir=D:\msvs8\SDK\v2.0
  FrameworkVersion=v2.0.50727
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  IDLEIZER_HALT_ON_IDLE=true
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LIBPATH=C:\WINDOWS\Microsoft.NET\Framework\v2.0.50727;D:\msvs8\VC\ATLMFC\LIB
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOG="c:\runner\buildbot-startup.log"
  LOGONSERVER=\\G-W732-SPOT-156
  MAKE_MODE=unix
  MOZBUILDDIR=C:\mozilla-build
  MOZILLABUILD=D:\mozilla-build
  MOZILLABUILDDRIVE=C:
  MOZILLABUILDPATH=\mozilla-build\
  MOZ_AIRBAG=1
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_HIDE_RESULTS_TABLE=1
  MOZ_MSVCVERSION=8
  MOZ_NO_REMOTE=1
  MOZ_TOOLS=D:\mozilla-build\moztools
  MSVCDir=D:\msvs8\VC
  MSYSTEM=MINGW32
  NO_EM_RESTART=1
  NO_FAIL_ON_TEST_ERRORS=1
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;C:\Program Files (x86)\Puppet Labs\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\puppet\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;C:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;C:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;C:\Program Files\Amazon\cfn-bootstrap\;C:\Program Files\Microsoft SQL Server\110\Tools\Binn\;C:\mozilla-build\buildbotve;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\python27;C:\opt\runner;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn;C:\Users\cltbld\AppData\Local\Programs\Common\Microsoft\Visual C++ for Python\9.0;;C:\mozilla-build\moztools\bin
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 62 Stepping 4, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3e04
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PROPERTIES_FILE=C:\slave\test/buildprops.json
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files\AWS Tools\PowerShell\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=G-W732-SPOT-156
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  VCINSTALLDIR=D:\msvs8\VC
  VCVARS=D:\msvs8\VC\bin\vcvars32.bat
  VSINSTALLDIR=D:\msvs8
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
Traceback (most recent call last):
  File "scripts/scripts/desktop_unittest.py", line 759, in <module>
    desktop_unittest = DesktopUnittest()
  File "scripts/scripts/desktop_unittest.py", line 184, in __init__
    config={'require_test_zip': True})
  File "C:\slave\test\scripts\mozharness\base\vcs\vcsbase.py", line 125, in __init__
    super(VCSScript, self).__init__(**kwargs)
  File "C:\slave\test\scripts\mozharness\base\script.py", line 1834, in __init__
    self.new_log_obj(default_log_level=default_log_level)
  File "C:\slave\test\scripts\mozharness\base\script.py", line 2164, in new_log_obj
    self.log_obj = MultiFileLogger(**log_config)
  File "C:\slave\test\scripts\mozharness\base\log.py", line 663, in __init__
    self.new_logger()
  File "C:\slave\test\scripts\mozharness\base\log.py", line 671, in new_logger
    BaseLogger.new_logger(self)
  File "C:\slave\test\scripts\mozharness\base\log.py", line 502, in new_logger
    log_format='%(message)s')
  File "C:\slave\test\scripts\mozharness\base\log.py", line 557, in add_file_handler
    os.remove(log_path)
WindowsError: [Error 32] The process cannot access the file because it is being used by another process: 'C:\\slave\\test\\logs\\log_raw.log'
program finished with exit code 1
elapsedTime=0.401000
========= master_lag: 0.21 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' warnings (results: 1, elapsed: 0 secs) (at 2017-06-12 15:28:48.205735) =========

========= Started no change (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:48.206533) =========
'cmd' '/C' 'for' '%f' 'in' '(*)' 'do' '@type' '%f'
 in dir C:\slave\test\properties (timeout 1200 secs)
 watching logfiles {}
 argv: ['cmd', '/C', 'for', '%f', 'in', '(*)', 'do', '@type', '%f']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  BUILDBOT_PATH=C:\mozilla-build\
  CHOCOLATEYINSTALL=C:\ProgramData\chocolatey
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=G-W732-SPOT-156
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  IDLEIZER_HALT_ON_IDLE=true
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOG="c:\runner\buildbot-startup.log"
  LOGONSERVER=\\G-W732-SPOT-156
  MAKE_MODE=unix
  MOZBUILDDIR=C:\mozilla-build
  MOZILLABUILD=C:\mozilla-build
  MOZ_TOOLS=C:\mozilla-build\moztools
  MSYSTEM=MINGW32
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;C:\Program Files (x86)\Puppet Labs\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\puppet\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;C:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;C:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;C:\Program Files\Amazon\cfn-bootstrap\;C:\Program Files\Microsoft SQL Server\110\Tools\Binn\;C:\mozilla-build\buildbotve;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\python27;C:\opt\runner;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn;C:\Users\cltbld\AppData\Local\Programs\Common\Microsoft\Visual C++ for Python\9.0;;C:\mozilla-build\moztools\bin
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 62 Stepping 4, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3e04
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files\AWS Tools\PowerShell\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test\properties
  RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=G-W732-SPOT-156
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
program finished with exit code 0
elapsedTime=0.101000

========= master_lag: 0.01 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:48.320316) =========

========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:48.320609) =========
'rm' '-f' 'oauth.txt'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-f', 'oauth.txt']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  BUILDBOT_PATH=C:\mozilla-build\
  CHOCOLATEYINSTALL=C:\ProgramData\chocolatey
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=G-W732-SPOT-156
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  IDLEIZER_HALT_ON_IDLE=true
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOG="c:\runner\buildbot-startup.log"
  LOGONSERVER=\\G-W732-SPOT-156
  MAKE_MODE=unix
  MOZBUILDDIR=C:\mozilla-build
  MOZILLABUILD=C:\mozilla-build
  MOZ_TOOLS=C:\mozilla-build\moztools
  MSYSTEM=MINGW32
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;C:\Program Files (x86)\Puppet Labs\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\puppet\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;C:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;C:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;C:\Program Files\Amazon\cfn-bootstrap\;C:\Program Files\Microsoft SQL Server\110\Tools\Binn\;C:\mozilla-build\buildbotve;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\python27;C:\opt\runner;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn;C:\Users\cltbld\AppData\Local\Programs\Common\Microsoft\Visual C++ for Python\9.0;;C:\mozilla-build\moztools\bin
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 62 Stepping 4, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3e04
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files\AWS Tools\PowerShell\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=G-W732-SPOT-156
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
program finished with exit code 0
elapsedTime=0.101000
========= master_lag: 0.01 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 15:28:48.429703) =========

========= Started reboot slave lost (results: 2, elapsed: 0 secs) (at 2017-06-12 15:28:48.429983) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/external_tools/count_and_reboot.py' '-f' '../reboot_count.txt' '-n' '1' '-z'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/external_tools/count_and_reboot.py', '-f', '../reboot_count.txt', '-n', '1', '-z']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  BUILDBOT_PATH=C:\mozilla-build\
  CHOCOLATEYINSTALL=C:\ProgramData\chocolatey
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=G-W732-SPOT-156
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  DevEnvDir=D:\msvs8\Common7\IDE
  FP_NO_HOST_CHECK=NO
  FrameworkDir=C:\WINDOWS\Microsoft.NET\Framework
  FrameworkSDKDir=D:\msvs8\SDK\v2.0
  FrameworkVersion=v2.0.50727
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  IDLEIZER_HALT_ON_IDLE=true
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LIBPATH=C:\WINDOWS\Microsoft.NET\Framework\v2.0.50727;D:\msvs8\VC\ATLMFC\LIB
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOG="c:\runner\buildbot-startup.log"
  LOGONSERVER=\\G-W732-SPOT-156
  MAKE_MODE=unix
  MOZBUILDDIR=C:\mozilla-build
  MOZILLABUILD=D:\mozilla-build
  MOZILLABUILDDRIVE=C:
  MOZILLABUILDPATH=\mozilla-build\
  MOZ_AIRBAG=1
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_HIDE_RESULTS_TABLE=1
  MOZ_MSVCVERSION=8
  MOZ_NO_REMOTE=1
  MOZ_TOOLS=D:\mozilla-build\moztools
  MSVCDir=D:\msvs8\VC
  MSYSTEM=MINGW32
  NO_EM_RESTART=1
  NO_FAIL_ON_TEST_ERRORS=1
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\Program Files (x86)\Microsoft SDKs\TypeScript\1.0\;C:\Program Files (x86)\Puppet Labs\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\puppet\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\ruby\bin;C:\Program Files (x86)\Puppet Labs\Puppet\sys\tools\bin;C:\Program Files (x86)\Windows Kits\8.0\Windows Performance Toolkit\;C:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;C:\Program Files\Amazon\cfn-bootstrap\;C:\Program Files\Microsoft SQL Server\110\Tools\Binn\;C:\mozilla-build\buildbotve;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;C:\mozilla-build\msys\mingw\bin;C:\mozilla-build\python27;C:\opt\runner;c:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;c:\Program Files\Microsoft SQL Server\100\DTS\Binn\;c:\Program Files\Microsoft SQL Server\100\Tools\Binn;C:\Users\cltbld\AppData\Local\Programs\Common\Microsoft\Visual C++ for Python\9.0;;C:\mozilla-build\moztools\bin
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 62 Stepping 4, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=3e04
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PROPERTIES_FILE=C:\slave\test/buildprops.json
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\;C:\Program Files\AWS Tools\PowerShell\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNNER_CONFIG_CMD=C:\opt\runner\Scripts\python2.7.exe C:\opt\runner\Scripts\runner-script.py -c c:\opt\runner\runner.cfg
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=G-W732-SPOT-156
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  VCINSTALLDIR=D:\msvs8\VC
  VCVARS=D:\msvs8\VC\bin\vcvars32.bat
  VSINSTALLDIR=D:\msvs8
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
************************************************************************************************
*********** END OF RUN - NOW DOING SCHEDULED REBOOT; FOLLOWING ERROR MESSAGE EXPECTED **********
************************************************************************************************
program finished with exit code 1073807364
elapsedTime=0.191000
========= master_lag: 0.03 =========
========= Finished reboot slave lost (results: 2, elapsed: 0 secs) (at 2017-06-12 15:28:48.651035) =========

========= Total master_lag: 3.92 =========