builder: mozilla-esr52_win7_vm_gfx-debug_test-reftest-2
slave: g-w732-spot-122
starttime: 1503597931.73
results: warnings (1)
buildid: 20170824100622
builduid: 26224eefe1ff4d6b88df735421e3bdb4
revision: cf5fe0389cfaf54caa882c15783bac92e257b478

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:31.727318) =========
master: http://buildbot-master129.bb.releng.usw2.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:31.727730) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:31.728021) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:31.798252) =========

========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:31.798769) =========
'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-122
  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-122
  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-122
  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
--11:05:30--  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%   39.02 MB/s

11:05:30 (39.02 MB/s) - `archiver_client.py' saved [12179/12179]

program finished with exit code 0
elapsedTime=0.377000
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:32.185144) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 11:05:32.185973) =========
11:05:27     INFO - --DOMWINDOW == 114 (0F557000) [pid = 2640] [serial = 62] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-baselines-004-ref.html]
11:05:27     INFO - --DOMWINDOW == 113 (0C093400) [pid = 2640] [serial = 25] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-video-stretch-001.html]
11:05:27     INFO - --DOMWINDOW == 112 (12242400) [pid = 2640] [serial = 26] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-video-stretch-001-ref.html]
11:05:27     INFO - --DOMWINDOW == 111 (10237000) [pid = 2640] [serial = 27] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 110 (10243800) [pid = 2640] [serial = 28] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-input-stretch-001.html]
11:05:27     INFO - --DOMWINDOW == 109 (105D0800) [pid = 2640] [serial = 29] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-input-stretch-001-ref.html]
11:05:27     INFO - --DOMWINDOW == 108 (17295400) [pid = 2640] [serial = 30] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 107 (11E91C00) [pid = 2640] [serial = 31] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-self-baseline-001.html]
11:05:27     INFO - --DOMWINDOW == 106 (16219800) [pid = 2640] [serial = 32] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-self-baseline-001-ref.html]
11:05:27     INFO - --DOMWINDOW == 105 (17D36000) [pid = 2640] [serial = 33] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 104 (17D42C00) [pid = 2640] [serial = 34] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-content-baseline-001.html]
11:05:27     INFO - --DOMWINDOW == 103 (17F34400) [pid = 2640] [serial = 35] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-content-baseline-001-ref.html]
11:05:27     INFO - --DOMWINDOW == 102 (18A03800) [pid = 2640] [serial = 36] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 101 (19132400) [pid = 2640] [serial = 37] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-content-baseline-002.html]
11:05:27     INFO - --DOMWINDOW == 100 (17D37400) [pid = 2640] [serial = 38] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-content-baseline-002-ref.html]
11:05:27     INFO - --DOMWINDOW == 99 (19721800) [pid = 2640] [serial = 39] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 98 (19C2F000) [pid = 2640] [serial = 40] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-mixed-baseline-001.html]
11:05:27     INFO - --DOMWINDOW == 97 (19F52800) [pid = 2640] [serial = 41] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-mixed-baseline-001-ref.html]
11:05:27     INFO - --DOMWINDOW == 96 (0BE7B800) [pid = 2640] [serial = 42] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 95 (0C7DC400) [pid = 2640] [serial = 43] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-mixed-baseline-002.html]
11:05:27     INFO - --DOMWINDOW == 94 (0C924C00) [pid = 2640] [serial = 44] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-mixed-baseline-002-ref.html]
11:05:27     INFO - --DOMWINDOW == 93 (0C930C00) [pid = 2640] [serial = 45] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 92 (0BE4B800) [pid = 2640] [serial = 46] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-mixed-baseline-003.html]
11:05:27     INFO - --DOMWINDOW == 91 (0CA34400) [pid = 2640] [serial = 47] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-mixed-baseline-003-ref.html]
11:05:27     INFO - --DOMWINDOW == 90 (0CA33400) [pid = 2640] [serial = 48] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 89 (0CEB7C00) [pid = 2640] [serial = 49] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-align-content-001.html]
11:05:27     INFO - --DOMWINDOW == 88 (0C932C00) [pid = 2640] [serial = 50] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-align-content-001-ref.html]
11:05:27     INFO - --DOMWINDOW == 87 (0CA67800) [pid = 2640] [serial = 51] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 86 (0F55F000) [pid = 2640] [serial = 52] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-justify-content-001.html]
11:05:27     INFO - --DOMWINDOW == 85 (0F528C00) [pid = 2640] [serial = 53] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-justify-content-001-ref.html]
11:05:27     INFO - --DOMWINDOW == 84 (11653400) [pid = 2640] [serial = 58] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-justify-content-003.html]
11:05:27     INFO - --DOMWINDOW == 83 (1A90C800) [pid = 2640] [serial = 24] [outer = 00000000] [url = about:blank]
11:05:27     INFO - --DOMWINDOW == 82 (11E8A400) [pid = 2640] [serial = 61] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-baselines-004.html]
11:05:27     INFO - --DOMWINDOW == 81 (149F1C00) [pid = 2640] [serial = 72] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 80 (1237F000) [pid = 2640] [serial = 71] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-column-gap-002-ref.html]
11:05:27     INFO - --DOMWINDOW == 79 (0C02B000) [pid = 2640] [serial = 68] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-column-gap-001-ref.html]
11:05:27     INFO - --DOMWINDOW == 78 (11E88800) [pid = 2640] [serial = 65] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-synthesized-baseline-001-ref.html]
11:05:27     INFO - --DOMWINDOW == 77 (1663F000) [pid = 2640] [serial = 81] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 76 (0C092400) [pid = 2640] [serial = 67] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-column-gap-001.html]
11:05:27     INFO - --DOMWINDOW == 75 (1224F000) [pid = 2640] [serial = 64] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-synthesized-baseline-001-ref.html]
11:05:27     INFO - --DOMWINDOW == 74 (12245C00) [pid = 2640] [serial = 69] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 73 (0FE62000) [pid = 2640] [serial = 60] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 72 (16638C00) [pid = 2640] [serial = 79] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-row-gap-001.html]
11:05:27     INFO - --DOMWINDOW == 71 (1057AC00) [pid = 2640] [serial = 75] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 70 (16637800) [pid = 2640] [serial = 80] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-row-gap-001-ref.html]
11:05:27     INFO - --DOMWINDOW == 69 (12244C00) [pid = 2640] [serial = 63] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 68 (0FE57400) [pid = 2640] [serial = 55] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-justify-content-002.html]
11:05:27     INFO - --DOMWINDOW == 67 (1237D800) [pid = 2640] [serial = 66] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 66 (1660B800) [pid = 2640] [serial = 74] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-column-gap-003-ref.html]
11:05:27     INFO - --DOMWINDOW == 65 (173E6C00) [pid = 2640] [serial = 78] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 64 (171F1400) [pid = 2640] [serial = 76] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-column-gap-004.html]
11:05:27     INFO - --DOMWINDOW == 63 (10579800) [pid = 2640] [serial = 70] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-column-gap-002.html]
11:05:27     INFO - --DOMWINDOW == 62 (1224E400) [pid = 2640] [serial = 73] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-column-gap-003.html]
11:05:27     INFO - --DOMWINDOW == 61 (1237A800) [pid = 2640] [serial = 77] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-column-gap-004-ref.html]
11:05:27     INFO - --DOMWINDOW == 60 (0C998000) [pid = 2640] [serial = 54] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - --DOMWINDOW == 59 (0FA16800) [pid = 2640] [serial = 59] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-justify-content-003-ref.html]
11:05:27     INFO - --DOMWINDOW == 58 (0C92E400) [pid = 2640] [serial = 56] [outer = 00000000] [url = file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-justify-content-002-ref.html]
11:05:27     INFO - --DOMWINDOW == 57 (1160F800) [pid = 2640] [serial = 57] [outer = 00000000] [url = data:text/html;charset=UTF-8,%3C%21%2D%2DCLEAR%2D%2D%3E]
11:05:27     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-003.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-003-ref.html
11:05:27     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-003.html | 39 / 7146 (0%)
11:05:27     INFO - ++DOMWINDOW == 58 (0C02EC00) [pid = 2640] [serial = 130] [outer = 1A902C00]
11:05:27     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-003-ref.html | 39 / 7146 (0%)
11:05:27     INFO - ++DOMWINDOW == 59 (0BEAE000) [pid = 2640] [serial = 131] [outer = 1A902C00]
11:05:28     INFO - REFTEST TEST-PASS | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-003.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-003-ref.html | image comparison
11:05:28     INFO - REFTEST TEST-END | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-003.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-003-ref.html
11:05:28     INFO - ++DOMWINDOW == 60 (0C92E400) [pid = 2640] [serial = 132] [outer = 1A902C00]
11:05:28     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-004.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-004-ref.html
11:05:28     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-004.html | 40 / 7146 (0%)
11:05:28     INFO - ++DOMWINDOW == 61 (0CA67400) [pid = 2640] [serial = 133] [outer = 1A902C00]
11:05:29     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-004-ref.html | 40 / 7146 (0%)
11:05:29     INFO - ++DOMWINDOW == 62 (0CDB9C00) [pid = 2640] [serial = 134] [outer = 1A902C00]
11:05:30     INFO - REFTEST TEST-PASS | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-004.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-004-ref.html | image comparison
11:05:30     INFO - REFTEST TEST-END | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-004.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-item-margin-right-auto-004-ref.html
11:05:30     INFO - ++DOMWINDOW == 63 (0C929000) [pid = 2640] [serial = 135] [outer = 1A902C00]
11:05:30     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-min-max-width-height-001.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-min-max-width-height-001-ref.html
11:05:30     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-min-max-width-height-001.html | 41 / 7146 (0%)
11:05:30     INFO - ++DOMWINDOW == 64 (0F556400) [pid = 2640] [serial = 136] [outer = 1A902C00]
11:05:30     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-min-max-width-height-001-ref.html | 41 / 7146 (0%)
11:05:30     INFO - ++DOMWINDOW == 65 (0C98D800) [pid = 2640] [serial = 137] [outer = 1A902C00]
11:05:30     INFO - REFTEST TEST-PASS | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-min-max-width-height-001.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-min-max-width-height-001-ref.html | image comparison
11:05:30     INFO - REFTEST TEST-END | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-min-max-width-height-001.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-container-min-max-width-height-001-ref.html
11:05:30     INFO - ++DOMWINDOW == 66 (0CA63800) [pid = 2640] [serial = 138] [outer = 1A902C00]
11:05:30     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-001.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-001-ref.html
11:05:30     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-001.html | 42 / 7146 (0%)
11:05:30     INFO - ++DOMWINDOW == 67 (0CDB8800) [pid = 2640] [serial = 139] [outer = 1A902C00]
11:05:31     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-001-ref.html | 42 / 7146 (0%)
11:05:31     INFO - ++DOMWINDOW == 68 (0FD8F400) [pid = 2640] [serial = 140] [outer = 1A902C00]
11:05:31     INFO - REFTEST TEST-PASS | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-001.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-001-ref.html | image comparison
11:05:31     INFO - REFTEST TEST-END | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-001.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-001-ref.html
11:05:31     INFO - ++DOMWINDOW == 69 (0FE5CC00) [pid = 2640] [serial = 141] [outer = 1A902C00]
11:05:31     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-002.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-002-ref.html
11:05:31     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-002.html | 43 / 7146 (0%)
11:05:31     INFO - ++DOMWINDOW == 70 (0FE60000) [pid = 2640] [serial = 142] [outer = 1A902C00]
11:05:31     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-002-ref.html | 43 / 7146 (0%)
11:05:31     INFO - ++DOMWINDOW == 71 (1023A400) [pid = 2640] [serial = 143] [outer = 1A902C00]
11:05:31     INFO - REFTEST TEST-PASS | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-002.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-002-ref.html | image comparison
11:05:31     INFO - REFTEST TEST-END | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-002.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-clamping-002-ref.html
11:05:31     INFO - ++DOMWINDOW == 72 (10237800) [pid = 2640] [serial = 144] [outer = 1A902C00]
11:05:31     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-repeat-auto-fill-fit-001.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-repeat-auto-fill-fit-001-ref.html
11:05:31     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-repeat-auto-fill-fit-001.html | 44 / 7146 (0%)
11:05:31     INFO - ++DOMWINDOW == 73 (10579800) [pid = 2640] [serial = 145] [outer = 1A902C00]
11:05:31     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-repeat-auto-fill-fit-001-ref.html | 44 / 7146 (0%)
11:05:31     INFO - ++DOMWINDOW == 74 (114DB400) [pid = 2640] [serial = 146] [outer = 1A902C00]
11:05:32     INFO - REFTEST TEST-PASS | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-repeat-auto-fill-fit-001.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-repeat-auto-fill-fit-001-ref.html | image comparison
11:05:32     INFO - REFTEST TEST-END | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-repeat-auto-fill-fit-001.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-repeat-auto-fill-fit-001-ref.html
11:05:32     INFO - ++DOMWINDOW == 75 (105D5C00) [pid = 2640] [serial = 147] [outer = 1A902C00]
11:05:32     INFO - REFTEST TEST-START | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-repeat-auto-fill-fit-002.html == file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-repeat-auto-fill-fit-002-ref.html
11:05:32     INFO - REFTEST TEST-LOAD | file:///C:/slave/test/build/tests/reftest/tests/layout/reftests/css-grid/grid-repeat-auto-fill-fit-002.html | 45 / 7146 (0%)
11:05:32     INFO - ++DOMWINDOW == 76 (1056F400) [pid = 2640] [serial = 148] [outer = 1A902C00]
'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-122
  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-122
  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-122
  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=1.901000
========= master_lag: 0.01 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 11:05:34.098774) =========

========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 11:05:34.099677) =========
'bash' '-c' u'python archiver_client.py mozharness --repo releases/mozilla-esr52 --rev cf5fe0389cfaf54caa882c15783bac92e257b478 --destination scripts --debug'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-esr52 --rev cf5fe0389cfaf54caa882c15783bac92e257b478 --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-122
  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-122
  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-122
  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-08-24 11:05:32,720 truncating revision to first 12 chars
2017-08-24 11:05:32,720 Setting DEBUG logging.
2017-08-24 11:05:32,720 attempt 1/10
2017-08-24 11:05:32,720 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-esr52/cf5fe0389cfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-08-24 11:05:33,727 unpacking tar archive at: mozilla-esr52-cf5fe0389cfa/testing/mozharness/
2017-08-24 11:05:33,888 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=1.573000
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 11:05:35.683112) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:35.683958) =========
script_repo_revision: cf5fe0389cfaf54caa882c15783bac92e257b478
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:35.685059) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:35.685642) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:35.692679) =========

========= Started 'c:/mozilla-build/python27/python -u ...' warnings (results: 1, elapsed: 0 secs) (at 2017-08-24 11:05:35.692954) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/desktop_unittest.py' '--cfg' 'unittests/win_unittest.py' '--reftest-suite' 'reftest' '--total-chunks' '2' '--this-chunk' '2' '--blob-upload-branch' 'mozilla-esr52' '--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', '--total-chunks', '2', '--this-chunk', '2', '--blob-upload-branch', 'mozilla-esr52', '--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-122
  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-122
  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-122
  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 741, 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 1800, in __init__
    self.new_log_obj(default_log_level=default_log_level)
  File "C:\slave\test\scripts\mozharness\base\script.py", line 2130, 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: 0.01 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' warnings (results: 1, elapsed: 0 secs) (at 2017-08-24 11:05:36.003125) =========

========= Started no change (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:36.003927) =========
'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-122
  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-122
  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-122
  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: 0.01 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:36.115513) =========

========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 11:05:36.115822) =========
'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-122
  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-122
  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-122
  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-08-24 11:05:36.224311) =========

========= Started reboot slave lost (results: 2, elapsed: 0 secs) (at 2017-08-24 11:05:36.224628) =========
'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-122
  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-122
  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-122
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  VCINSTALLDIR=D:\msvs8\VC
  VCVARS=D:\msvs8\VC\bin\vcvars32.bat
  VSINSTALLDIR=D:\msvs8
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
************************************************************************************************
*********** END OF RUN - NOW DOING SCHEDULED REBOOT; FOLLOWING ERROR MESSAGE EXPECTED **********
************************************************************************************************
program finished with exit code 1073807364
elapsedTime=0.191000
========= master_lag: 0.03 =========
========= Finished reboot slave lost (results: 2, elapsed: 0 secs) (at 2017-08-24 11:05:36.441213) =========

========= Total master_lag: 0.08 =========