builder: mozilla-central_win7_vm_gfx-debug_test-reftest-gpu-e10s
slave: g-w732-spot-197
starttime: 1494444336.77
results: warnings (1)
buildid: 20170510111622
builduid: bb846f6326c54e87a7ef00548c799ba5
revision: 8a43b69fbae255a2af98f11507862437d6303033

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:36.768909) =========
master: http://buildbot-master139.bb.releng.usw2.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:36.769583) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:36.770058) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:36.845272) =========

========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:36.845686) =========
'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-197
  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-197
  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 45 Stepping 7, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=2d07
  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-197
  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
--12:25:35--  https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
           => `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|: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%    7.84 MB/s

12:25:35 (7.84 MB/s) - `archiver_client.py' saved [12179/12179]

program finished with exit code 0
elapsedTime=0.425000
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:37.280670) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2017-05-10 12:25:37.281515) =========
12:25:31     INFO - [Child 5496] WARNING: Subsequent listeners are not retargetable: file c:/builds/moz2_slave/m-cen-w32-d-000000000000000000/build/src/netwerk/protocol/http/HttpChannelChild.cpp, line 3070
12:25:32     INFO - REFTEST TEST-LOAD | http://localhost:49419/1494443951593/108/encoder.html?img=size-2x2.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp | 812 / 15334 (5%)
12:25:32     INFO - ++DOMWINDOW == 28 (0739DC00) [pid = 5496] [serial = 2224] [outer = 0761C000]
12:25:33     INFO - REFTEST TEST-PASS | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-2x2.png == http://localhost:49419/1494443951593/108/encoder.html?img=size-2x2.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp | image comparison
12:25:33     INFO - REFTEST TEST-END | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-2x2.png == http://localhost:49419/1494443951593/108/encoder.html?img=size-2x2.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp
12:25:33     INFO - ++DOMWINDOW == 29 (07692400) [pid = 5496] [serial = 2225] [outer = 0761C000]
12:25:33     INFO - REFTEST None
12:25:33     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-3x3.png == http://localhost:49419/1494443951594/109/encoder.html?img=size-3x3.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp
12:25:33     INFO - REFTEST TEST-LOAD | http://localhost:49419/1494443951594/109/size-3x3.png | 813 / 15334 (5%)
12:25:33     INFO - ++DOMWINDOW == 30 (071D8800) [pid = 5496] [serial = 2226] [outer = 0761C000]
12:25:33     INFO - [Child 5496] WARNING: Subsequent listeners are not retargetable: file c:/builds/moz2_slave/m-cen-w32-d-000000000000000000/build/src/netwerk/protocol/http/HttpChannelChild.cpp, line 3070
12:25:34     INFO - REFTEST TEST-LOAD | http://localhost:49419/1494443951594/109/encoder.html?img=size-3x3.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp | 813 / 15334 (5%)
12:25:34     INFO - ++DOMWINDOW == 31 (0739EC00) [pid = 5496] [serial = 2227] [outer = 0761C000]
12:25:35     INFO - REFTEST TEST-PASS | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-3x3.png == http://localhost:49419/1494443951594/109/encoder.html?img=size-3x3.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp | image comparison
12:25:35     INFO - REFTEST TEST-END | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-3x3.png == http://localhost:49419/1494443951594/109/encoder.html?img=size-3x3.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp
12:25:35     INFO - ++DOMWINDOW == 32 (07696800) [pid = 5496] [serial = 2228] [outer = 0761C000]
12:25:35     INFO - REFTEST None
12:25:35     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-4x4.png == http://localhost:49419/1494443951596/110/encoder.html?img=size-4x4.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp
12:25:35     INFO - REFTEST TEST-LOAD | http://localhost:49419/1494443951596/110/size-4x4.png | 814 / 15334 (5%)
12:25:35     INFO - ++DOMWINDOW == 33 (07693C00) [pid = 5496] [serial = 2229] [outer = 0761C000]
12:25:35     INFO - [Child 5496] WARNING: Subsequent listeners are not retargetable: file c:/builds/moz2_slave/m-cen-w32-d-000000000000000000/build/src/netwerk/protocol/http/HttpChannelChild.cpp, line 3070
12:25:35     INFO - REFTEST TEST-LOAD | http://localhost:49419/1494443951596/110/encoder.html?img=size-4x4.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp | 814 / 15334 (5%)
12:25:36     INFO - ++DOMWINDOW == 34 (012E6C00) [pid = 5496] [serial = 2230] [outer = 0761C000]
'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-197
  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-197
  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 45 Stepping 7, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=2d07
  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-197
  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.01 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2017-05-10 12:25:39.393249) =========

========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-05-10 12:25:39.394232) =========
'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev 8a43b69fbae255a2af98f11507862437d6303033 --destination scripts --debug'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8a43b69fbae255a2af98f11507862437d6303033 --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-197
  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-197
  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 45 Stepping 7, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=2d07
  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-197
  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-05-10 12:25:39,496 truncating revision to first 12 chars
2017-05-10 12:25:39,496 Setting DEBUG logging.
2017-05-10 12:25:39,496 attempt 1/10
2017-05-10 12:25:39,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a43b69fbae2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-05-10 12:25:40,756 unpacking tar archive at: mozilla-central-8a43b69fbae2/testing/mozharness/
2017-05-10 12:25:40,964 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=3.429000
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-05-10 12:25:42.834374) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:42.835228) =========
script_repo_revision: 8a43b69fbae255a2af98f11507862437d6303033
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:42.836280) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:42.836813) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:42.846209) =========

========= Started 'c:/mozilla-build/python27/python -u ...' warnings (results: 1, elapsed: 1 secs) (at 2017-05-10 12:25:42.846484) =========
12:25:36     INFO - --DOMWINDOW == 33 (012AB000) [pid = 5496] [serial = 2204] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
12:25:36     INFO - --DOMWINDOW == 32 (012A2C00) [pid = 5496] [serial = 2205] [outer = 00000000] [url = http://localhost:49419/1494443951582/102/size-17x17.png]
12:25:36     INFO - --DOMWINDOW == 31 (012DFC00) [pid = 5496] [serial = 2206] [outer = 00000000] [url = http://localhost:49419/1494443951582/102/encoder.html?img=size-17x17.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D32%3Bformat%3Dbmp]
12:25:36     INFO - --DOMWINDOW == 30 (012E8400) [pid = 5496] [serial = 2207] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
12:25:36     INFO - --DOMWINDOW == 29 (012A2400) [pid = 5496] [serial = 2208] [outer = 00000000] [url = http://localhost:49419/1494443951583/103/size-31x31.png]
12:25:36     INFO - --DOMWINDOW == 28 (012DCC00) [pid = 5496] [serial = 2197] [outer = 00000000] [url = http://localhost:49419/1494443951576/99/encoder.html?img=size-9x9.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D32%3Bformat%3Dbmp]
12:25:36     INFO - --DOMWINDOW == 27 (012E5C00) [pid = 5496] [serial = 2199] [outer = 00000000] [url = http://localhost:49419/1494443951578/100/size-15x15.png]
12:25:36     INFO - --DOMWINDOW == 26 (0129E800) [pid = 5496] [serial = 2200] [outer = 00000000] [url = http://localhost:49419/1494443951578/100/encoder.html?img=size-15x15.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D32%3Bformat%3Dbmp]
12:25:36     INFO - --DOMWINDOW == 25 (012A6C00) [pid = 5496] [serial = 2201] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
12:25:36     INFO - --DOMWINDOW == 24 (012A9800) [pid = 5496] [serial = 2202] [outer = 00000000] [url = http://localhost:49419/1494443951579/101/size-16x16.png]
12:25:36     INFO - --DOMWINDOW == 23 (012A4800) [pid = 5496] [serial = 2203] [outer = 00000000] [url = http://localhost:49419/1494443951579/101/encoder.html?img=size-16x16.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D32%3Bformat%3Dbmp]
12:25:37     INFO - REFTEST TEST-PASS | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-4x4.png == http://localhost:49419/1494443951596/110/encoder.html?img=size-4x4.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp | image comparison
12:25:37     INFO - REFTEST TEST-END | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-4x4.png == http://localhost:49419/1494443951596/110/encoder.html?img=size-4x4.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp
12:25:37     INFO - ++DOMWINDOW == 24 (012A7000) [pid = 5496] [serial = 2231] [outer = 0761C000]
12:25:37     INFO - REFTEST None
12:25:37     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-5x5.png == http://localhost:49419/1494443951598/111/encoder.html?img=size-5x5.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp
12:25:37     INFO - REFTEST TEST-LOAD | http://localhost:49419/1494443951598/111/size-5x5.png | 815 / 15334 (5%)
12:25:37     INFO - ++DOMWINDOW == 25 (012A2800) [pid = 5496] [serial = 2232] [outer = 0761C000]
12:25:37     INFO - [Child 5496] WARNING: Subsequent listeners are not retargetable: file c:/builds/moz2_slave/m-cen-w32-d-000000000000000000/build/src/netwerk/protocol/http/HttpChannelChild.cpp, line 3070
12:25:38     INFO - REFTEST TEST-LOAD | http://localhost:49419/1494443951598/111/encoder.html?img=size-5x5.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp | 815 / 15334 (5%)
12:25:38     INFO - ++DOMWINDOW == 26 (012A9000) [pid = 5496] [serial = 2233] [outer = 0761C000]
12:25:39     INFO - REFTEST TEST-PASS | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-5x5.png == http://localhost:49419/1494443951598/111/encoder.html?img=size-5x5.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp | image comparison
12:25:39     INFO - REFTEST TEST-END | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-5x5.png == http://localhost:49419/1494443951598/111/encoder.html?img=size-5x5.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp
12:25:39     INFO - ++DOMWINDOW == 27 (012E2C00) [pid = 5496] [serial = 2234] [outer = 0761C000]
12:25:39     INFO - REFTEST None
12:25:39     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-6x6.png == http://localhost:49419/1494443951600/112/encoder.html?img=size-6x6.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp
12:25:39     INFO - REFTEST TEST-LOAD | http://localhost:49419/1494443951600/112/size-6x6.png | 816 / 15334 (5%)
12:25:39     INFO - ++DOMWINDOW == 28 (012E6000) [pid = 5496] [serial = 2235] [outer = 0761C000]
12:25:39     INFO - [Child 5496] WARNING: Subsequent listeners are not retargetable: file c:/builds/moz2_slave/m-cen-w32-d-000000000000000000/build/src/netwerk/protocol/http/HttpChannelChild.cpp, line 3070
12:25:40     INFO - REFTEST TEST-LOAD | http://localhost:49419/1494443951600/112/encoder.html?img=size-6x6.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp | 816 / 15334 (5%)
12:25:40     INFO - ++DOMWINDOW == 29 (012A1800) [pid = 5496] [serial = 2236] [outer = 0761C000]
12:25:41     INFO - REFTEST TEST-PASS | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-6x6.png == http://localhost:49419/1494443951600/112/encoder.html?img=size-6x6.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp | image comparison
12:25:41     INFO - REFTEST TEST-END | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-6x6.png == http://localhost:49419/1494443951600/112/encoder.html?img=size-6x6.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp
12:25:41     INFO - ++DOMWINDOW == 30 (071DFC00) [pid = 5496] [serial = 2237] [outer = 0761C000]
12:25:41     INFO - REFTEST None
12:25:41     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/image/test/reftest/encoders-lossless/size-7x7.png == http://localhost:49419/1494443951601/113/encoder.html?img=size-7x7.png&mime=image/vnd.microsoft.icon&options=-moz-parse-options%3Abpp%3D24%3Bformat%3Dbmp
12:25:41     INFO - REFTEST TEST-LOAD | http://localhost:49419/1494443951601/113/size-7x7.png | 817 / 15334 (5%)
12:25:41     INFO - ++DOMWINDOW == 31 (012AB800) [pid = 5496] [serial = 2238] [outer = 0761C000]
12:25:41     INFO - [Child 5496] WARNING: Subsequent listeners are not retargetable: file c:/builds/moz2_slave/m-cen-w32-d-000000000000000000/build/src/netwerk/protocol/http/HttpChannelChild.cpp, line 3070
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/desktop_unittest.py' '--cfg' 'unittests/win_unittest.py' '--reftest-suite' 'reftest-gpu' '--e10s' '--blob-upload-branch' 'mozilla-central' '--download-symbols' 'true'
 in dir C:\slave\test\. (timeout 1800 secs) (maxTime 7200 secs)
 watching logfiles {}
 argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/desktop_unittest.py', '--cfg', 'unittests/win_unittest.py', '--reftest-suite', 'reftest-gpu', '--e10s', '--blob-upload-branch', 'mozilla-central', '--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-197
  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-197
  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 45 Stepping 7, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=2d07
  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-197
  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 750, in <module>
    desktop_unittest = DesktopUnittest()
  File "scripts/scripts/desktop_unittest.py", line 178, 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 1832, in __init__
    self.new_log_obj(default_log_level=default_log_level)
  File "C:\slave\test\scripts\mozharness\base\script.py", line 2162, in new_log_obj
    self.log_obj = MultiFileLogger(**log_config)
  File "C:\slave\test\scripts\mozharness\base\log.py", line 659, in __init__
    self.new_logger()
  File "C:\slave\test\scripts\mozharness\base\log.py", line 667, in new_logger
    BaseLogger.new_logger(self)
  File "C:\slave\test\scripts\mozharness\base\log.py", line 498, in new_logger
    log_format='%(message)s')
  File "C:\slave\test\scripts\mozharness\base\log.py", line 553, 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=1.002000
========= master_lag: 0.01 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' warnings (results: 1, elapsed: 1 secs) (at 2017-05-10 12:25:43.858924) =========

========= Started no change (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:43.859848) =========
'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-197
  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-197
  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 45 Stepping 7, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=2d07
  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-197
  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-05-10 12:25:43.971972) =========

========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:25:43.972264) =========
'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-197
  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-197
  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 45 Stepping 7, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=2d07
  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-197
  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-05-10 12:25:44.081576) =========

========= Started reboot slave lost (results: 2, elapsed: 0 secs) (at 2017-05-10 12:25:44.081859) =========
'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-197
  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-197
  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 45 Stepping 7, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=2d07
  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-197
  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.284000
========= master_lag: 0.64 =========
========= Finished reboot slave lost (results: 2, elapsed: 0 secs) (at 2017-05-10 12:25:45.007170) =========

========= Total master_lag: 0.70 =========