builder: mozilla-inbound_win7_vm_gfx-debug_test-mochitest-gl-1
slave: g-w732-spot-151
starttime: 1492133160.28
results: warnings (1)
buildid: 20170413170149
builduid: 26ef1c1e64f849e4a048057fcf8e1931
revision: a5664e5049e9d1701cfd44908271d99a836ef60e

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 18:26:00.279391) =========
master: http://buildbot-master139.bb.releng.usw2.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 18:26:00.279896) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 27 secs) (at 2017-04-13 18:26:00.280199) =========
18:26:03     INFO - GECKO(4520) | --DOCSHELL 0D46E400 == 8 [pid = 4520] [id = {e08f5d46-d7ae-4e31-8d4b-6d2d900230aa}]
18:26:03     INFO - GECKO(4520) | Destroying context 0EB6C800 surface 0C629600 on display 0CD6D5E0
18:26:03     INFO - GECKO(4520) | Destroying context 0DF92000 surface 0C60C200 on display 0CD6D5E0
18:26:03     INFO - GECKO(4520) | --DOMWINDOW == 28 (0C594000) [pid = 4520] [serial = 3669] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-r32f-red-float.html]
18:26:03     INFO - GECKO(4520) | --DOMWINDOW == 27 (0C61EC00) [pid = 4520] [serial = 3671] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-r32f-red-float.html?webglVersion=2]
18:26:03     INFO - GECKO(4520) | --DOMWINDOW == 26 (0C2A0C00) [pid = 4520] [serial = 3674] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-r32f-red-float.html?webglVersion=2]
18:26:03     INFO - GECKO(4520) | --DOMWINDOW == 25 (0C90A800) [pid = 4520] [serial = 3673] [outer = 00000000] [url = about:blank]
18:26:03     INFO - GECKO(4520) | --DOMWINDOW == 24 (0CFE4400) [pid = 4520] [serial = 3675] [outer = 00000000] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:26:03     INFO - GECKO(4520) | --DOMWINDOW == 23 (0D46F000) [pid = 4520] [serial = 3680] [outer = 00000000] [url = about:blank]
18:26:04     INFO - GECKO(4520) | MEMORY STAT | vsize 938MB | vsizeMaxContiguous 308MB | residentFast 207MB | heapAllocated 78MB
18:26:05     INFO - TEST-OK | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-r8ui-red_integer-unsigned_byte.html | took 9805ms
18:26:05     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:05     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:05     INFO - GECKO(4520) | ++DOMWINDOW == 24 (0D470800) [pid = 4520] [serial = 3689] [outer = 1BE79C00]
18:26:05     INFO - TEST-START | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rg16f-rg-float.html
18:26:05     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:05     INFO - GECKO(4520) | --DOCSHELL 09587800 == 7 [pid = 4520] [id = {a86e3db6-2433-4665-91ed-a411bdf1c58e}]
18:26:05     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:05     INFO - GECKO(4520) | ++DOMWINDOW == 25 (09586000) [pid = 4520] [serial = 3690] [outer = 1BE79C00]
18:26:05     INFO - GECKO(4520) | ++DOCSHELL 0C905800 == 8 [pid = 4520] [id = {dfd0730a-3834-45cb-ba13-ec3bbcaa0ad4}]
18:26:05     INFO - GECKO(4520) | ++DOMWINDOW == 26 (0C90F400) [pid = 4520] [serial = 3691] [outer = 00000000]
18:26:05     INFO - GECKO(4520) | ++DOMWINDOW == 27 (0958F400) [pid = 4520] [serial = 3692] [outer = 0C90F400]
18:26:05     INFO - GECKO(4520) | ++DOCSHELL 0D624000 == 9 [pid = 4520] [id = {bb0bf3dd-748e-41ff-b0ba-1bf7a2920336}]
18:26:05     INFO - GECKO(4520) | ++DOMWINDOW == 28 (0D624400) [pid = 4520] [serial = 3693] [outer = 00000000]
18:26:05     INFO - GECKO(4520) | [4520] WARNING: 'NS_FAILED(rv)', file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/caps/BasePrincipal.cpp, line 380
18:26:05     INFO - GECKO(4520) | ++DOMWINDOW == 29 (0D622400) [pid = 4520] [serial = 3694] [outer = 0D624400]
18:26:05     INFO - GECKO(4520) | ++DOMWINDOW == 30 (0D46FC00) [pid = 4520] [serial = 3695] [outer = 0D624400]
18:26:05     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:26:05     INFO - GECKO(4520) | Initializing context 10F1D000 surface 0CD15980 on display 0CD6D5E0
18:26:05     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:26:05     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926
18:26:05     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:26:05     INFO - GECKO(4520) | Initializing context 1171B000 surface 0CD15F00 on display 0CD6D5E0
18:26:05     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:26:05     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926

18:26:09     INFO - GECKO(4520) | --DOCSHELL 09590000 == 8 [pid = 4520] [id = {eec62770-4fb7-4594-a62c-92796da95397}]
18:26:11     INFO - GECKO(4520) | --DOMWINDOW == 29 (09588C00) [pid = 4520] [serial = 3684] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-r8ui-red_integer-unsigned_byte.html?webglVersion=2]
18:26:11     INFO - GECKO(4520) | --DOMWINDOW == 28 (0D46E800) [pid = 4520] [serial = 3679] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-r8-red-unsigned_byte.html?webglVersion=2]
18:26:11     INFO - GECKO(4520) | --DOMWINDOW == 27 (0CFE2800) [pid = 4520] [serial = 3677] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-r8-red-unsigned_byte.html?webglVersion=2]
18:26:11     INFO - GECKO(4520) | --DOMWINDOW == 26 (09590400) [pid = 4520] [serial = 3686] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-r8ui-red_integer-unsigned_byte.html?webglVersion=2]

18:26:15     INFO - GECKO(4520) | MEMORY STAT | vsize 938MB | vsizeMaxContiguous 308MB | residentFast 206MB | heapAllocated 79MB
18:26:15     INFO - TEST-OK | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rg16f-rg-float.html | took 10185ms
18:26:15     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:15     INFO - GECKO(4520) | ++DOMWINDOW == 27 (008E7800) [pid = 4520] [serial = 3696] [outer = 1BE79C00]
18:26:15     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:15     INFO - TEST-START | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rg16f-rg-half_float.html
18:26:15     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:15     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:15     INFO - GECKO(4520) | ++DOMWINDOW == 28 (09582C00) [pid = 4520] [serial = 3697] [outer = 1BE79C00]
18:26:15     INFO - GECKO(4520) | --DOCSHELL 0C905800 == 7 [pid = 4520] [id = {dfd0730a-3834-45cb-ba13-ec3bbcaa0ad4}]
18:26:15     INFO - GECKO(4520) | ++DOCSHELL 008F0800 == 8 [pid = 4520] [id = {9a24e6c1-4f97-4be9-aee6-f92d3aa5fac7}]
18:26:15     INFO - GECKO(4520) | ++DOMWINDOW == 29 (008F0C00) [pid = 4520] [serial = 3698] [outer = 00000000]
18:26:15     INFO - GECKO(4520) | Destroying context 129B2000 surface 0CD15500 on display 0CD6D5E0
18:26:15     INFO - GECKO(4520) | Destroying context 0D407000 surface 0C236A80 on display 0CD6D5E0
18:26:15     INFO - GECKO(4520) | --DOMWINDOW == 28 (008F4000) [pid = 4520] [serial = 3687] [outer = 00000000] [url = about:blank]
18:26:15     INFO - GECKO(4520) | --DOMWINDOW == 27 (008EF000) [pid = 4520] [serial = 3682] [outer = 00000000] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:26:15     INFO - GECKO(4520) | Destroying context 129B0000 surface 0CD15300 on display 0CD6D5E0
18:26:15     INFO - GECKO(4520) | Destroying context 0D408800 surface 0C2ABC80 on display 0CD6D5E0
18:26:15     INFO - GECKO(4520) | --DOMWINDOW == 26 (0958E400) [pid = 4520] [serial = 3688] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-r8ui-red_integer-unsigned_byte.html?webglVersion=2]
18:26:15     INFO - GECKO(4520) | --DOMWINDOW == 25 (0CFDD400) [pid = 4520] [serial = 3681] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-r8-red-unsigned_byte.html?webglVersion=2]
18:26:15     INFO - GECKO(4520) | --DOMWINDOW == 24 (008F2000) [pid = 4520] [serial = 3685] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-r8ui-red_integer-unsigned_byte.html?webglVersion=2]
18:26:15     INFO - GECKO(4520) | --DOMWINDOW == 23 (0D46CC00) [pid = 4520] [serial = 3678] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-r8-red-unsigned_byte.html?webglVersion=2]
18:26:15     INFO - GECKO(4520) | --DOMWINDOW == 22 (008EA000) [pid = 4520] [serial = 3683] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-r8ui-red_integer-unsigned_byte.html]
18:26:15     INFO - GECKO(4520) | --DOMWINDOW == 21 (0C903800) [pid = 4520] [serial = 3676] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-r8-red-unsigned_byte.html]
18:26:15     INFO - GECKO(4520) | ++DOMWINDOW == 22 (08E06800) [pid = 4520] [serial = 3699] [outer = 008F0C00]
18:26:15     INFO - GECKO(4520) | ++DOCSHELL 09586400 == 9 [pid = 4520] [id = {03acc596-21c2-43c5-95e0-95c49ac58423}]
18:26:15     INFO - GECKO(4520) | ++DOMWINDOW == 23 (09586C00) [pid = 4520] [serial = 3700] [outer = 00000000]
18:26:15     INFO - GECKO(4520) | [4520] WARNING: 'NS_FAILED(rv)', file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/caps/BasePrincipal.cpp, line 380
18:26:15     INFO - GECKO(4520) | ++DOMWINDOW == 24 (008F6C00) [pid = 4520] [serial = 3701] [outer = 09586C00]
18:26:15     INFO - GECKO(4520) | ++DOMWINDOW == 25 (008F2400) [pid = 4520] [serial = 3702] [outer = 09586C00]
18:26:15     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:26:15     INFO - GECKO(4520) | Initializing context 0CAE0000 surface 0BDE2100 on display 0CD6D5E0
18:26:15     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:26:15     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926
18:26:16     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:26:16     INFO - GECKO(4520) | Initializing context 0CAEA800 surface 0BDE2400 on display 0CD6D5E0
18:26:16     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:26:16     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926

========= Finished downloading to buildprops.json (results: 0, elapsed: 27 secs) (at 2017-04-13 18:26:27.663944) =========

========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 18:26:27.664617) =========
'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-151
  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-151
  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-151
  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
--18:26:26--  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%    8.26 MB/s

18:26:27 (8.26 MB/s) - `archiver_client.py' saved [12179/12179]

program finished with exit code 0
elapsedTime=0.367000
========= master_lag: 0.26 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 18:26:28.293058) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 14 secs) (at 2017-04-13 18:26:28.293739) =========
18:26:23     INFO - GECKO(4520) | --DOMWINDOW == 24 (0D622400) [pid = 4520] [serial = 3694] [outer = 00000000] [url = about:blank]
18:26:23     INFO - GECKO(4520) | --DOMWINDOW == 23 (0D470800) [pid = 4520] [serial = 3689] [outer = 00000000] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:26:24     INFO - GECKO(4520) | MEMORY STAT | vsize 938MB | vsizeMaxContiguous 308MB | residentFast 204MB | heapAllocated 75MB
18:26:24     INFO - TEST-OK | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rg16f-rg-half_float.html | took 9346ms
18:26:24     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:24     INFO - GECKO(4520) | ++DOMWINDOW == 24 (0CF2A400) [pid = 4520] [serial = 3703] [outer = 1BE79C00]
18:26:24     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:24     INFO - TEST-START | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rg32f-rg-float.html
18:26:24     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:24     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:24     INFO - GECKO(4520) | ++DOMWINDOW == 25 (008E9400) [pid = 4520] [serial = 3704] [outer = 1BE79C00]
18:26:24     INFO - GECKO(4520) | ++DOCSHELL 0CF28000 == 10 [pid = 4520] [id = {fa8be954-d38a-4532-8d19-7ef0c0b11853}]
18:26:24     INFO - GECKO(4520) | ++DOMWINDOW == 26 (0CF28400) [pid = 4520] [serial = 3705] [outer = 00000000]
18:26:25     INFO - GECKO(4520) | ++DOMWINDOW == 27 (0CF2B400) [pid = 4520] [serial = 3706] [outer = 0CF28400]
18:26:25     INFO - GECKO(4520) | ++DOCSHELL 0CFD8400 == 11 [pid = 4520] [id = {dcbfde75-7390-4433-8032-f4f106caa5f4}]
18:26:25     INFO - GECKO(4520) | ++DOMWINDOW == 28 (0CFD8800) [pid = 4520] [serial = 3707] [outer = 00000000]
18:26:25     INFO - GECKO(4520) | [4520] WARNING: 'NS_FAILED(rv)', file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/caps/BasePrincipal.cpp, line 380
18:26:25     INFO - GECKO(4520) | ++DOMWINDOW == 29 (0CFD8C00) [pid = 4520] [serial = 3708] [outer = 0CFD8800]
18:26:25     INFO - GECKO(4520) | ++DOMWINDOW == 30 (0CF25400) [pid = 4520] [serial = 3709] [outer = 0CFD8800]
18:26:25     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:26:25     INFO - GECKO(4520) | Initializing context 0D4BF800 surface 0CA8C200 on display 0CD6D5E0
18:26:25     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:26:25     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926
18:26:25     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:26:25     INFO - GECKO(4520) | Initializing context 0D4C6000 surface 0CA8C480 on display 0CD6D5E0
18:26:25     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:26:25     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926
18:26:27     INFO - GECKO(4520) | --DOMWINDOW == 29 (0C90F400) [pid = 4520] [serial = 3691] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-rg16f-rg-float.html?webglVersion=2]
18:26:27     INFO - GECKO(4520) | --DOMWINDOW == 28 (0D624400) [pid = 4520] [serial = 3693] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-rg16f-rg-float.html?webglVersion=2]
'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-151
  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-151
  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-151
  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.002000
========= master_lag: 12.29 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 14 secs) (at 2017-04-13 18:26:42.584030) =========

========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2017-04-13 18:26:42.585829) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a5664e5049e9d1701cfd44908271d99a836ef60e --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 a5664e5049e9d1701cfd44908271d99a836ef60e --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-151
  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-151
  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-151
  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-04-13 18:26:42,390 truncating revision to first 12 chars
2017-04-13 18:26:42,390 Setting DEBUG logging.
2017-04-13 18:26:42,390 attempt 1/10
2017-04-13 18:26:42,390 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a5664e5049e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-04-13 18:26:43,319 unpacking tar archive at: mozilla-inbound-a5664e5049e9/testing/mozharness/
2017-04-13 18:26:43,513 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=1.624000
========= master_lag: 6.44 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2017-04-13 18:26:50.647604) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 18:26:50.648296) =========
script_repo_revision: a5664e5049e9d1701cfd44908271d99a836ef60e
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 18:26:50.649246) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 31 secs) (at 2017-04-13 18:26:50.649898) =========
18:26:50     INFO - GECKO(4520) | --DOMWINDOW == 28 (0CFD8C00) [pid = 4520] [serial = 3708] [outer = 00000000] [url = about:blank]
18:26:50     INFO - GECKO(4520) | --DOMWINDOW == 27 (0D466400) [pid = 4520] [serial = 3710] [outer = 00000000] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:26:50     INFO - GECKO(4520) | --DOMWINDOW == 26 (0D46C800) [pid = 4520] [serial = 3715] [outer = 00000000] [url = about:blank]
18:26:50     INFO - GECKO(4520) | Destroying context 0D4C6000 surface 0CA8C480 on display 0CD6D5E0
18:26:50     INFO - GECKO(4520) | --DOMWINDOW == 25 (008E9400) [pid = 4520] [serial = 3704] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rg32f-rg-float.html]
18:26:50     INFO - GECKO(4520) | --DOMWINDOW == 24 (0CF2B400) [pid = 4520] [serial = 3706] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-rg32f-rg-float.html?webglVersion=2]
18:26:50     INFO - GECKO(4520) | --DOMWINDOW == 23 (0CF25400) [pid = 4520] [serial = 3709] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-rg32f-rg-float.html?webglVersion=2]
18:26:50     INFO - GECKO(4520) | Destroying context 0D4BF800 surface 0CA8C200 on display 0CD6D5E0
18:26:52     INFO - GECKO(4520) | MEMORY STAT | vsize 938MB | vsizeMaxContiguous 308MB | residentFast 199MB | heapAllocated 77MB
18:26:52     INFO - TEST-OK | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rg8ui-rg_integer-unsigned_byte.html | took 9055ms
18:26:52     INFO - GECKO(4520) | ++DOMWINDOW == 24 (0CA99000) [pid = 4520] [serial = 3724] [outer = 1BE79C00]
18:26:52     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:52     INFO - TEST-START | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rgb16f-rgb-float.html
18:26:52     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:53     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:26:53     INFO - GECKO(4520) | ++DOMWINDOW == 25 (0CD80C00) [pid = 4520] [serial = 3725] [outer = 1BE79C00]
18:26:53     INFO - GECKO(4520) | ++DOCSHELL 0E07F400 == 16 [pid = 4520] [id = {5481ec62-8ccb-45a6-80da-c44160a72bdc}]
18:26:53     INFO - GECKO(4520) | ++DOMWINDOW == 26 (0E087000) [pid = 4520] [serial = 3726] [outer = 00000000]
18:26:53     INFO - GECKO(4520) | ++DOMWINDOW == 27 (0E435400) [pid = 4520] [serial = 3727] [outer = 0E087000]
18:26:53     INFO - GECKO(4520) | ++DOCSHELL 0E438C00 == 17 [pid = 4520] [id = {03b0c28c-d527-4beb-9994-2dd999f592e0}]
18:26:53     INFO - GECKO(4520) | ++DOMWINDOW == 28 (0E439000) [pid = 4520] [serial = 3728] [outer = 00000000]
18:26:53     INFO - GECKO(4520) | [4520] WARNING: 'NS_FAILED(rv)', file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/caps/BasePrincipal.cpp, line 380
18:26:53     INFO - GECKO(4520) | ++DOMWINDOW == 29 (0E434000) [pid = 4520] [serial = 3729] [outer = 0E439000]
18:26:53     INFO - GECKO(4520) | ++DOMWINDOW == 30 (0E437000) [pid = 4520] [serial = 3730] [outer = 0E439000]
18:26:53     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:26:53     INFO - GECKO(4520) | Initializing context 0D4BF000 surface 0CD16800 on display 0CD6D5E0
18:26:53     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:26:53     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926
18:26:53     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:26:53     INFO - GECKO(4520) | Initializing context 0D4C2800 surface 0CD16B00 on display 0CD6D5E0
18:26:53     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:26:53     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926
18:26:54     INFO - GECKO(4520) | --DOMWINDOW == 29 (0D46F000) [pid = 4520] [serial = 3714] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-rg8-rg-unsigned_byte.html?webglVersion=2]
18:26:54     INFO - GECKO(4520) | --DOMWINDOW == 28 (0D465000) [pid = 4520] [serial = 3712] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-rg8-rg-unsigned_byte.html?webglVersion=2]

18:26:59     INFO - GECKO(4520) | Destroying context 0E41B800 surface 0CE94480 on display 0CD6D5E0
18:26:59     INFO - GECKO(4520) | Destroying context 0E415000 surface 0CE8EA80 on display 0CD6D5E0
18:26:59     INFO - GECKO(4520) | --DOMWINDOW == 27 (0C9A8400) [pid = 4520] [serial = 3717] [outer = 00000000] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:26:59     INFO - GECKO(4520) | --DOMWINDOW == 26 (0BDF0C00) [pid = 4520] [serial = 3711] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rg8-rg-unsigned_byte.html]
18:26:59     INFO - GECKO(4520) | --DOMWINDOW == 25 (0D46CC00) [pid = 4520] [serial = 3713] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-rg8-rg-unsigned_byte.html?webglVersion=2]
18:26:59     INFO - GECKO(4520) | --DOMWINDOW == 24 (0BDFE000) [pid = 4520] [serial = 3716] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-rg8-rg-unsigned_byte.html?webglVersion=2]
18:27:02     INFO - GECKO(4520) | --DOMWINDOW == 23 (0CD85C00) [pid = 4520] [serial = 3721] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-rg8ui-rg_integer-unsigned_byte.html?webglVersion=2]
18:27:02     INFO - GECKO(4520) | --DOMWINDOW == 22 (0CD80800) [pid = 4520] [serial = 3719] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-rg8ui-rg_integer-unsigned_byte.html?webglVersion=2]
18:27:03     INFO - GECKO(4520) | MEMORY STAT | vsize 938MB | vsizeMaxContiguous 308MB | residentFast 202MB | heapAllocated 78MB
18:27:03     INFO - TEST-OK | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rgb16f-rgb-float.html | took 11042ms
18:27:03     INFO - GECKO(4520) | ++DOMWINDOW == 23 (0D46CC00) [pid = 4520] [serial = 3731] [outer = 1BE79C00]
18:27:03     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:27:03     INFO - TEST-START | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rgb16f-rgb-half_float.html
18:27:03     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:27:03     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:27:03     INFO - GECKO(4520) | ++DOMWINDOW == 24 (0CAA0800) [pid = 4520] [serial = 3732] [outer = 1BE79C00]
18:27:04     INFO - GECKO(4520) | ++DOCSHELL 008E9000 == 18 [pid = 4520] [id = {c017cfa8-012a-46cc-8e73-1b01fe7d6d10}]
18:27:04     INFO - GECKO(4520) | ++DOMWINDOW == 25 (008E9400) [pid = 4520] [serial = 3733] [outer = 00000000]
18:27:04     INFO - GECKO(4520) | --DOMWINDOW == 24 (0C984000) [pid = 4520] [serial = 3718] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rg8ui-rg_integer-unsigned_byte.html]
18:27:04     INFO - GECKO(4520) | --DOMWINDOW == 23 (0C97C400) [pid = 4520] [serial = 3723] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-rg8ui-rg_integer-unsigned_byte.html?webglVersion=2]
18:27:04     INFO - GECKO(4520) | --DOMWINDOW == 22 (0CA23C00) [pid = 4520] [serial = 3720] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-rg8ui-rg_integer-unsigned_byte.html?webglVersion=2]
18:27:04     INFO - GECKO(4520) | --DOMWINDOW == 21 (0CD83000) [pid = 4520] [serial = 3722] [outer = 00000000] [url = about:blank]
18:27:04     INFO - GECKO(4520) | --DOMWINDOW == 20 (0CA99000) [pid = 4520] [serial = 3724] [outer = 00000000] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:27:04     INFO - GECKO(4520) | --DOMWINDOW == 19 (0E434000) [pid = 4520] [serial = 3729] [outer = 00000000] [url = about:blank]
18:27:04     INFO - GECKO(4520) | Destroying context 11713800 surface 0CAFB680 on display 0CD6D5E0
18:27:04     INFO - GECKO(4520) | Destroying context 10F11800 surface 0CAFB380 on display 0CD6D5E0
18:27:04     INFO - GECKO(4520) | ++DOMWINDOW == 20 (008EF000) [pid = 4520] [serial = 3734] [outer = 008E9400]
18:27:04     INFO - GECKO(4520) | ++DOCSHELL 008F4C00 == 19 [pid = 4520] [id = {74412fa8-dfe7-4aa3-839e-2cb23254bbff}]
18:27:04     INFO - GECKO(4520) | ++DOMWINDOW == 21 (008F5800) [pid = 4520] [serial = 3735] [outer = 00000000]
18:27:04     INFO - GECKO(4520) | [4520] WARNING: 'NS_FAILED(rv)', file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/caps/BasePrincipal.cpp, line 380
18:27:04     INFO - GECKO(4520) | ++DOMWINDOW == 22 (008EE000) [pid = 4520] [serial = 3736] [outer = 008F5800]
18:27:04     INFO - GECKO(4520) | ++DOMWINDOW == 23 (0958D400) [pid = 4520] [serial = 3737] [outer = 008F5800]
18:27:04     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:27:04     INFO - GECKO(4520) | Initializing context 0D0C6800 surface 0BE0BA80 on display 0CD6D5E0
18:27:04     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:27:04     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926
18:27:04     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:27:04     INFO - GECKO(4520) | Initializing context 0D0CA000 surface 0BE0C100 on display 0CD6D5E0
18:27:04     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:27:04     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926

========= Finished downloading to oauth.txt (results: 0, elapsed: 31 secs) (at 2017-04-13 18:27:22.337010) =========

========= Started 'c:/mozilla-build/python27/python -u ...' warnings (results: 1, elapsed: 5 secs) (at 2017-04-13 18:27:22.337783) =========
18:27:20     INFO - GECKO(4520) | --DOCSHELL 0D624000 == 20 [pid = 4520] [id = {bb0bf3dd-748e-41ff-b0ba-1bf7a2920336}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 008F4C00 == 19 [pid = 4520] [id = {74412fa8-dfe7-4aa3-839e-2cb23254bbff}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 008E9000 == 18 [pid = 4520] [id = {c017cfa8-012a-46cc-8e73-1b01fe7d6d10}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 0E438C00 == 17 [pid = 4520] [id = {03b0c28c-d527-4beb-9994-2dd999f592e0}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 0E07F400 == 16 [pid = 4520] [id = {5481ec62-8ccb-45a6-80da-c44160a72bdc}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 0CD85400 == 15 [pid = 4520] [id = {47ed9a8c-2c49-4c85-941e-b96359b4b010}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 0CD80400 == 14 [pid = 4520] [id = {30692bb6-bd35-48a0-963c-476485ff67e7}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 0D46E800 == 13 [pid = 4520] [id = {b300f63c-5193-44ef-8812-280ead2efae1}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 0D464C00 == 12 [pid = 4520] [id = {b1c0a3c5-b2d7-4f60-8fd9-7328999c337b}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 0CFD8400 == 11 [pid = 4520] [id = {dcbfde75-7390-4433-8032-f4f106caa5f4}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 0CF28000 == 10 [pid = 4520] [id = {fa8be954-d38a-4532-8d19-7ef0c0b11853}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 09586400 == 9 [pid = 4520] [id = {03acc596-21c2-43c5-95e0-95c49ac58423}]
18:27:20     INFO - GECKO(4520) | --DOCSHELL 008F0800 == 8 [pid = 4520] [id = {9a24e6c1-4f97-4be9-aee6-f92d3aa5fac7}]
18:27:20     INFO - GECKO(4520) | --DOMWINDOW == 27 (0CD80C00) [pid = 4520] [serial = 3725] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rgb16f-rgb-float.html]
18:27:20     INFO - GECKO(4520) | Destroying context 0D4C2800 surface 0CD16B00 on display 0CD6D5E0
18:27:20     INFO - GECKO(4520) | --DOMWINDOW == 26 (0E437000) [pid = 4520] [serial = 3730] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-rgb16f-rgb-float.html?webglVersion=2]
18:27:20     INFO - GECKO(4520) | --DOMWINDOW == 25 (0D46CC00) [pid = 4520] [serial = 3731] [outer = 00000000] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:27:20     INFO - GECKO(4520) | --DOMWINDOW == 24 (0E435400) [pid = 4520] [serial = 3727] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-rgb16f-rgb-float.html?webglVersion=2]
18:27:20     INFO - GECKO(4520) | --DOMWINDOW == 23 (008EE000) [pid = 4520] [serial = 3736] [outer = 00000000] [url = about:blank]
18:27:20     INFO - GECKO(4520) | Destroying context 0D4BF000 surface 0CD16800 on display 0CD6D5E0
18:27:23     INFO - GECKO(4520) | --DOMWINDOW == 22 (008E9400) [pid = 4520] [serial = 3733] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/mochi-single.html?checkout/conformance2/textures/webgl_canvas/tex-2d-rgb16f-rgb-half_float.html?webglVersion=2]
18:27:23     INFO - GECKO(4520) | --DOMWINDOW == 21 (008F5800) [pid = 4520] [serial = 3735] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/conformance2/textures/webgl_canvas/tex-2d-rgb16f-rgb-half_float.html?webglVersion=2]
18:27:24     INFO - GECKO(4520) | MEMORY STAT | vsize 946MB | vsizeMaxContiguous 308MB | residentFast 207MB | heapAllocated 77MB
18:27:24     INFO - TEST-OK | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rgb32f-rgb-float.html | took 10370ms
18:27:24     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:27:24     INFO - GECKO(4520) | ++DOMWINDOW == 22 (11C90400) [pid = 4520] [serial = 3745] [outer = 1BE79C00]
18:27:24     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:27:24     INFO - TEST-START | dom/canvas/test/webgl-conf/generated/test_2_conformance2__textures__webgl_canvas__tex-2d-rgb565-rgb-unsigned_byte.html
18:27:24     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:27:24     INFO - GECKO(4520) | --DOCSHELL 0E081800 == 7 [pid = 4520] [id = {168ff7a6-0921-46dd-a8b8-3a7343029a2a}]
18:27:24     INFO - GECKO(4520) | [4520] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
18:27:24     INFO - GECKO(4520) | ++DOMWINDOW == 23 (095E6800) [pid = 4520] [serial = 3746] [outer = 1BE79C00]
18:27:24     INFO - GECKO(4520) | ++DOCSHELL 11C8F800 == 8 [pid = 4520] [id = {ca1fdba0-4f99-4ccd-bede-0f3ff45aa020}]
18:27:24     INFO - GECKO(4520) | ++DOMWINDOW == 24 (11C8FC00) [pid = 4520] [serial = 3747] [outer = 00000000]
18:27:24     INFO - GECKO(4520) | ++DOMWINDOW == 25 (11C92400) [pid = 4520] [serial = 3748] [outer = 11C8FC00]
18:27:24     INFO - GECKO(4520) | ++DOCSHELL 11C99000 == 9 [pid = 4520] [id = {6d540328-05ba-43f9-bdf3-fe1da70990ae}]
18:27:24     INFO - GECKO(4520) | ++DOMWINDOW == 26 (11C99400) [pid = 4520] [serial = 3749] [outer = 00000000]
18:27:24     INFO - GECKO(4520) | [4520] WARNING: 'NS_FAILED(rv)', file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/caps/BasePrincipal.cpp, line 380
18:27:24     INFO - GECKO(4520) | ++DOMWINDOW == 27 (11C97000) [pid = 4520] [serial = 3750] [outer = 11C99400]
18:27:24     INFO - GECKO(4520) | ++DOMWINDOW == 28 (0CF10800) [pid = 4520] [serial = 3751] [outer = 11C99400]
18:27:24     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:27:24     INFO - GECKO(4520) | Initializing context 0D41C000 surface 0CEAD900 on display 0CD6D5E0
18:27:24     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:27:24     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926
18:27:24     INFO - GECKO(4520) | err: gl::Context::Context(266): 	! Unimplemented: gl::Context::Context(266)
18:27:24     INFO - GECKO(4520) | Initializing context 0D41D800 surface 0CEADB00 on display 0CD6D5E0
18:27:24     INFO - GECKO(4520) | [4520] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContext.cpp, line 995
18:27:24     INFO - GECKO(4520) | [4520] WARNING: robustness marked as unsupported: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/src/gfx/gl/GLContextFeatures.cpp, line 926
'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' '1' '--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', '1', '--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-151
  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-151
  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-151
  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 743, in <module>
    desktop_unittest = DesktopUnittest()
  File "scripts/scripts/desktop_unittest.py", line 172, 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 1794, in __init__
    self.new_log_obj(default_log_level=default_log_level)
  File "C:\slave\test\scripts\mozharness\base\script.py", line 2124, 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=0.301000
========= master_lag: 5.61 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' warnings (results: 1, elapsed: 5 secs) (at 2017-04-13 18:27:28.253106) =========

========= Started no change (results: 0, elapsed: 3 secs) (at 2017-04-13 18:27:28.253900) =========
'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-151
  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-151
  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-151
  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.102000

========= master_lag: 3.82 =========
========= Finished no change (results: 0, elapsed: 3 secs) (at 2017-04-13 18:27:32.172601) =========

========= Started 'rm -f ...' (results: 0, elapsed: 13 secs) (at 2017-04-13 18:27:32.172982) =========
'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-151
  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-151
  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-151
  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: 13.52 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 13 secs) (at 2017-04-13 18:27:45.794263) =========

========= Started reboot slave lost (results: 2, elapsed: 4 secs) (at 2017-04-13 18:27:45.794716) =========
'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-151
  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-151
  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-151
  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: 4.28 =========
========= Finished reboot slave lost (results: 2, elapsed: 4 secs) (at 2017-04-13 18:27:50.266441) =========

========= Total master_lag: 46.22 =========