builder: mozilla-aurora_win7-ix-debug_test-reftest slave: t-w732-ix-123 starttime: 1446113885.91 results: success (0) buildid: 20151029014646 builduid: e2197d6fa76745edba8eadefeb37f684 revision: 41fdefd640f368bccdeafe6446d42c0a5ad22797 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:05.911521) ========= master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:05.912989) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:05.913318) ========= 'cd' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['cd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-123 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-123 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: 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\ PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\cltbld\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-123 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 C:\slave\test program finished with exit code 0 elapsedTime=0.697000 basedir: 'C:\\slave\\test' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:06.703470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:06.704061) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:06.884606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-10-29 03:18:06.885106) ========= 'rm' '-rf' 'properties' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-123 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-123 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: 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\ PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\cltbld\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-123 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.201000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-10-29 03:18:07.886914) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:07.887244) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:07.887948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:07.888240) ========= '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 COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-123 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-123 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: 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\ PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\cltbld\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-123 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 --03:18:09-- 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. HTTP request sent, awaiting response... 200 Script output follows Length: 12,141 (12K) [text/x-python] 0K .......... . 100% 1.96 GB/s 03:18:09 (1.96 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.764000 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:08.683181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2015-10-29 03:18:08.683508) ========= 'rm' '-rf' 'scripts' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-123 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-123 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: 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\ PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\cltbld\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-123 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=4.001000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2015-10-29 03:18:13.534320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 26 secs) (at 2015-10-29 03:18:13.534723) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 41fdefd640f368bccdeafe6446d42c0a5ad22797 --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-aurora --rev 41fdefd640f368bccdeafe6446d42c0a5ad22797 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-123 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-123 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: 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\ PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\cltbld\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-123 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 2015-10-29 03:18:14,792 truncating revision to first 12 chars 2015-10-29 03:18:14,792 Setting DEBUG logging. 2015-10-29 03:18:14,792 attempt 1/10 2015-10-29 03:18:14,792 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/41fdefd640f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-29 03:18:16,069 unpacking tar archive at: mozilla-aurora-41fdefd640f3/testing/mozharness/ program finished with exit code 0 elapsedTime=2.076000 ========= Finished 'bash -c ...' (results: 0, elapsed: 26 secs) (at 2015-10-29 03:18:39.590407) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:39.590940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:40.177306) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:40.177737) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-29 03:18:40.187429) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 1 hrs, 7 mins, 23 secs) (at 2015-10-29 03:18:40.188114) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/desktop_unittest.py' '--cfg' 'unittests/win_unittest.py' '--reftest-suite' 'reftest' '--blob-upload-branch' 'mozilla-aurora' '--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', '--blob-upload-branch', 'mozilla-aurora', '--download-symbols', 'true'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-123 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 HOMEDRIVE=C: HOMEPATH=\Users\cltbld 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 LOGONSERVER=\\T-W732-IX-123 MONDIR=C:\Monitor_config\ 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 NO_EM_RESTART=1 NO_FAIL_ON_TEST_ERRORS=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: 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\ PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 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\ PUBLIC=C:\Users\Public PWD=C:\slave\test RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\cltbld\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-123 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 03:18:41 INFO - MultiFileLogger online at 20151029 03:18:41 in C:\slave\test 03:18:41 INFO - Run as scripts/scripts/desktop_unittest.py --cfg unittests/win_unittest.py --reftest-suite reftest --blob-upload-branch mozilla-aurora --download-symbols true 03:18:41 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 03:18:41 INFO - {'all_cppunittest_suites': {'cppunittest': ('tests/cppunittest',)}, 03:18:41 INFO - 'all_gtest_suites': {'gtest': ()}, 03:18:41 INFO - 'all_jittest_suites': {'jittest': ()}, 03:18:41 INFO - 'all_mochitest_suites': {'a11y': ('--a11y',), 03:18:41 INFO - 'browser-chrome': ('--browser-chrome',), 03:18:41 INFO - 'browser-chrome-addons': ('--browser-chrome', 03:18:41 INFO - '--chunk-by-runtime', 03:18:41 INFO - '--tag=addons'), 03:18:41 INFO - 'browser-chrome-chunked': ('--browser-chrome', 03:18:41 INFO - '--chunk-by-runtime'), 03:18:41 INFO - 'chrome': ('--chrome',), 03:18:41 INFO - 'jetpack-addon': ('--jetpack-addon',), 03:18:41 INFO - 'jetpack-package': ('--jetpack-package',), 03:18:41 INFO - 'mochitest-devtools-chrome': ('--browser-chrome', 03:18:41 INFO - '--subsuite=devtools'), 03:18:41 INFO - 'mochitest-devtools-chrome-chunked': ('--browser-chrome', 03:18:41 INFO - '--subsuite=devtools', 03:18:41 INFO - '--chunk-by-runtime'), 03:18:41 INFO - 'mochitest-gl': ('--subsuite=webgl',), 03:18:41 INFO - 'mochitest-metro-chrome': ('--browser-chrome', 03:18:41 INFO - '--metro-immersive'), 03:18:41 INFO - 'mochitest-push': ('--subsuite=push',), 03:18:41 INFO - 'plain': (), 03:18:41 INFO - 'plain-chunked': ('--chunk-by-dir=4',)}, 03:18:41 INFO - 'all_mozbase_suites': {'mozbase': ()}, 03:18:41 INFO - 'all_reftest_suites': {'crashtest': {'options': ('--suite=crashtest',), 03:18:41 INFO - 'tests': ('tests/reftest/tests/testing/crashtest/crashtests.list',)}, 03:18:41 INFO - 'crashtest-ipc': {'options': ('--suite=crashtest', 03:18:41 INFO - '--setpref=browser.tabs.remote=true', 03:18:41 INFO - '--setpref=browser.tabs.remote.autostart=true', 03:18:41 INFO - '--setpref=layers.async-pan-zoom.enabled=true'), 03:18:41 INFO - 'tests': ('tests/reftest/tests/testing/crashtest/crashtests.list',)}, 03:18:41 INFO - 'jsreftest': {'options': ('--extra-profile-file=tests/jsreftest/tests/user.js',), 03:18:41 INFO - 'tests': ('tests/jsreftest/tests/jstests.list',)}, 03:18:41 INFO - 'reftest': {'options': ('--suite=reftest',), 03:18:41 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)}, 03:18:41 INFO - 'reftest-ipc': {'options': ('--suite=reftest', 03:18:41 INFO - '--setpref=browser.tabs.remote=true', 03:18:41 INFO - '--setpref=browser.tabs.remote.autostart=true', 03:18:41 INFO - '--setpref=layers.async-pan-zoom.enabled=true'), 03:18:41 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest-sanity/reftest.list',)}, 03:18:41 INFO - 'reftest-no-accel': {'options': ('--suite=reftest', 03:18:41 INFO - '--setpref=gfx.direct2d.disabled=true', 03:18:41 INFO - '--setpref=layers.acceleration.disabled=true'), 03:18:41 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)}, 03:18:41 INFO - 'reftest-omtc': {'options': ('--suite=reftest', 03:18:41 INFO - '--setpref=layers.offmainthreadcomposition.enabled=true'), 03:18:41 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)}}, 03:18:41 INFO - 'all_webapprt_suites': {'chrome': ('--webapprt-chrome', 03:18:41 INFO - '--browser-arg=-test-mode'), 03:18:41 INFO - 'content': ('--webapprt-content',)}, 03:18:41 INFO - 'all_xpcshell_suites': {'xpcshell': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell.exe', 03:18:41 INFO - '--manifest=tests/xpcshell/tests/all-test-dirs.list'), 03:18:41 INFO - 'tests': ()}, 03:18:41 INFO - 'xpcshell-addons': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell.exe', 03:18:41 INFO - '--tag=addons', 03:18:41 INFO - '--manifest=tests/xpcshell/tests/all-test-dirs.list'), 03:18:41 INFO - 'tests': ()}}, 03:18:41 INFO - 'append_to_log': False, 03:18:41 INFO - 'base_work_dir': 'C:\\slave\\test', 03:18:41 INFO - 'binary_path': 'C:\\slave\\test\\build\\firefox\\firefox.exe', 03:18:41 INFO - 'blob_upload_branch': 'mozilla-aurora', 03:18:41 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 03:18:41 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:41 INFO - 'buildbot_max_log_size': 52428800, 03:18:41 INFO - 'code_coverage': False, 03:18:41 INFO - 'config_files': ('unittests/win_unittest.py',), 03:18:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:41 INFO - 'download_minidump_stackwalk': True, 03:18:41 INFO - 'download_symbols': 'true', 03:18:41 INFO - 'e10s': False, 03:18:41 INFO - 'exe_suffix': '.exe', 03:18:41 INFO - 'exes': {'hg': 'c:/mozilla-build/hg/hg', 03:18:41 INFO - 'mozinstall': ('C:\\slave\\test/build/venv/scripts/python', 03:18:41 INFO - 'C:\\slave\\test/build/venv/scripts/mozinstall-script.py'), 03:18:41 INFO - 'python': 'c:\\mozilla-build\\python27\\python.exe', 03:18:41 INFO - 'tooltool.py': ('c:\\mozilla-build\\python27\\python.exe', 03:18:41 INFO - 'C:/mozilla-build/tooltool.py'), 03:18:41 INFO - 'virtualenv': ('c:\\mozilla-build\\python27\\python.exe', 03:18:41 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 03:18:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:41 INFO - 'installer_path': 'C:\\slave\\test\\build\\installer.zip', 03:18:41 INFO - 'log_level': 'info', 03:18:41 INFO - 'log_to_console': True, 03:18:41 INFO - 'minidump_save_path': '%(abs_work_dir)s/../minidumps', 03:18:41 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 03:18:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 03:18:41 INFO - 'minimum_tests_zip_dirs': ('bin/*', 03:18:41 INFO - 'certs/*', 03:18:41 INFO - 'modules/*', 03:18:41 INFO - 'mozbase/*', 03:18:41 INFO - 'config/*'), 03:18:41 INFO - 'no_random': False, 03:18:41 INFO - 'opt_config_files': (), 03:18:41 INFO - 'pip_index': False, 03:18:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:18:41 INFO - 'cmd': ('xset', 's', 'off', 's', 'reset'), 03:18:41 INFO - 'enabled': False, 03:18:41 INFO - 'halt_on_failure': False, 03:18:41 INFO - 'name': 'disable_screen_saver'}, 03:18:41 INFO - {'architectures': ('32bit',), 03:18:41 INFO - 'cmd': ('c:\\mozilla-build\\python27\\python.exe', 03:18:41 INFO - '../scripts/external_tools/mouse_and_screen_resolution.py', 03:18:41 INFO - '--configuration-url', 03:18:41 INFO - 'https://hg.mozilla.org/%(repo_path)s/raw-file/%(revision)s/testing/machine-configuration.json'), 03:18:41 INFO - 'enabled': True, 03:18:41 INFO - 'halt_on_failure': True, 03:18:41 INFO - 'name': 'run mouse & screen adjustment script'}), 03:18:41 INFO - 'require_test_zip': True, 03:18:41 INFO - 'run_all_suites': False, 03:18:41 INFO - 'run_cmd_checks_enabled': True, 03:18:41 INFO - 'run_file_names': {'cppunittest': 'runcppunittests.py', 03:18:41 INFO - 'gtest': 'rungtests.py', 03:18:41 INFO - 'jittest': 'jit_test.py', 03:18:41 INFO - 'mochitest': 'runtests.py', 03:18:41 INFO - 'mozbase': 'test.py', 03:18:41 INFO - 'mozmill': 'runtestlist.py', 03:18:41 INFO - 'reftest': 'runreftest.py', 03:18:41 INFO - 'webapprt': 'runtests.py', 03:18:41 INFO - 'xpcshell': 'runxpcshelltests.py'}, 03:18:41 INFO - 'specific_tests_zip_dirs': {'cppunittest': ('cppunittest/*',), 03:18:41 INFO - 'gtest': ('gtest/*',), 03:18:41 INFO - 'jittest': ('jit-test/*',), 03:18:41 INFO - 'mochitest': ('mochitest/*',), 03:18:41 INFO - 'mozbase': ('mozbase/*',), 03:18:41 INFO - 'mozmill': ('mozmill/*',), 03:18:41 INFO - 'reftest': ('reftest/*', 'jsreftest/*'), 03:18:41 INFO - 'webapprt': ('mochitest/*',), 03:18:41 INFO - 'xpcshell': ('xpcshell/*',)}, 03:18:41 INFO - 'specified_reftest_suites': ('reftest',), 03:18:41 INFO - 'strict_content_sandbox': False, 03:18:41 INFO - 'suite_definitions': {'cppunittest': {'options': ('--symbols-path=%(symbols_path)s', 03:18:41 INFO - '--xre-path=%(abs_app_dir)s'), 03:18:41 INFO - 'run_filename': 'runcppunittests.py', 03:18:41 INFO - 'testsdir': 'cppunittest'}, 03:18:41 INFO - 'gtest': {'options': ('--xre-path=%(abs_res_dir)s', 03:18:41 INFO - '--cwd=%(gtest_dir)s', 03:18:41 INFO - '--symbols-path=%(symbols_path)s', 03:18:41 INFO - '%(binary_path)s'), 03:18:41 INFO - 'run_filename': 'rungtests.py'}, 03:18:41 INFO - 'jittest': {'options': ('tests/bin/js', 03:18:41 INFO - '--no-slow', 03:18:41 INFO - '--no-progress', 03:18:41 INFO - '--format=automation', 03:18:41 INFO - '--jitflags=all'), 03:18:41 INFO - 'run_filename': 'jit_test.py', 03:18:41 INFO - 'testsdir': 'jit-test/jit-test'}, 03:18:41 INFO - 'mochitest': {'options': ('--appname=%(binary_path)s', 03:18:41 INFO - '--utility-path=tests/bin', 03:18:41 INFO - '--extra-profile-file=tests/bin/plugins', 03:18:41 INFO - '--symbols-path=%(symbols_path)s', 03:18:41 INFO - '--certificate-path=tests/certs', 03:18:41 INFO - '--quiet', 03:18:41 INFO - '--log-raw=%(raw_log_file)s', 03:18:41 INFO - '--log-errorsummary=%(error_summary_file)s', 03:18:41 INFO - '--screenshot-on-fail'), 03:18:41 INFO - 'run_filename': 'runtests.py', 03:18:41 INFO - 'testsdir': 'mochitest'}, 03:18:41 INFO - 'mozbase': {'options': ('-b', '%(binary_path)s'), 03:18:41 INFO - 'run_filename': 'test.py', 03:18:41 INFO - 'testsdir': 'mozbase'}, 03:18:41 INFO - 'mozmill': {'options': ('--binary=%(binary_path)s', 03:18:41 INFO - '--testing-modules-dir=test/modules', 03:18:41 INFO - '--symbols-path=%(symbols_path)s'), 03:18:41 INFO - 'run_filename': 'runtestlist.py', 03:18:41 INFO - 'testsdir': 'mozmill'}, 03:18:41 INFO - 'reftest': {'options': ('--appname=%(binary_path)s', 03:18:41 INFO - '--utility-path=tests/bin', 03:18:41 INFO - '--extra-profile-file=tests/bin/plugins', 03:18:41 INFO - '--symbols-path=%(symbols_path)s'), 03:18:41 INFO - 'run_filename': 'runreftest.py', 03:18:41 INFO - 'testsdir': 'reftest'}, 03:18:41 INFO - 'webapprt': {'options': ('--app=%(app_path)s', 03:18:41 INFO - '--utility-path=tests/bin', 03:18:41 INFO - '--extra-profile-file=tests/bin/plugins', 03:18:41 INFO - '--symbols-path=%(symbols_path)s', 03:18:41 INFO - '--certificate-path=tests/certs', 03:18:41 INFO - '--console-level=INFO', 03:18:41 INFO - '--testing-modules-dir=tests/modules', 03:18:41 INFO - '--quiet'), 03:18:41 INFO - 'run_filename': 'runtests.py', 03:18:41 INFO - 'testsdir': 'mochitest'}, 03:18:41 INFO - 'xpcshell': {'options': ('--symbols-path=%(symbols_path)s', 03:18:41 INFO - '--test-plugin-path=%(test_plugin_path)s', 03:18:41 INFO - '--log-raw=%(raw_log_file)s', 03:18:41 INFO - '--log-errorsummary=%(error_summary_file)s', 03:18:41 INFO - '--utility-path=tests/bin'), 03:18:41 INFO - 'run_filename': 'runxpcshelltests.py', 03:18:41 INFO - 'testsdir': 'xpcshell'}}, 03:18:41 INFO - 'vcs_output_timeout': 1000, 03:18:41 INFO - 'virtualenv_path': 'venv', 03:18:41 INFO - 'virtualenv_python_dll': 'c:\\mozilla-build\\python27\\python27.dll', 03:18:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:41 INFO - 'work_dir': 'build', 03:18:41 INFO - 'xpcshell_name': 'xpcshell.exe'} 03:18:41 INFO - ##### 03:18:41 INFO - ##### Running clobber step. 03:18:41 INFO - ##### 03:18:41 INFO - Running pre-action listener: _resource_record_pre_action 03:18:41 INFO - Running main action method: clobber 03:18:41 INFO - rmtree: C:\slave\test\build 03:18:41 INFO - Using _rmtree_windows ... 03:18:41 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 03:21:34 INFO - Running post-action listener: _resource_record_post_action 03:21:34 INFO - ##### 03:21:34 INFO - ##### Running read-buildbot-config step. 03:21:34 INFO - ##### 03:21:34 INFO - Running pre-action listener: _resource_record_pre_action 03:21:34 INFO - Running main action method: read_buildbot_config 03:21:34 INFO - Using buildbot properties: 03:21:34 INFO - { 03:21:34 INFO - "properties": { 03:21:34 INFO - "buildnumber": 19, 03:21:34 INFO - "product": "firefox", 03:21:34 INFO - "script_repo_revision": "production", 03:21:34 INFO - "branch": "mozilla-aurora", 03:21:34 INFO - "repository": "", 03:21:34 INFO - "buildername": "Windows 7 32-bit mozilla-aurora debug test reftest", 03:21:34 INFO - "buildid": "20151029014646", 03:21:34 INFO - "slavename": "t-w732-ix-123", 03:21:34 INFO - "pgo_build": "False", 03:21:34 INFO - "basedir": "C:\\slave\\test", 03:21:34 INFO - "project": "", 03:21:34 INFO - "platform": "win32", 03:21:34 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/", 03:21:34 INFO - "slavebuilddir": "test", 03:21:34 INFO - "scheduler": "tests-mozilla-aurora-win7-ix-debug-unittest", 03:21:34 INFO - "repo_path": "releases/mozilla-aurora", 03:21:34 INFO - "moz_repo_path": "", 03:21:34 INFO - "stage_platform": "win32", 03:21:34 INFO - "builduid": "e2197d6fa76745edba8eadefeb37f684", 03:21:34 INFO - "revision": "41fdefd640f368bccdeafe6446d42c0a5ad22797" 03:21:34 INFO - }, 03:21:34 INFO - "sourcestamp": { 03:21:34 INFO - "repository": "", 03:21:34 INFO - "hasPatch": false, 03:21:34 INFO - "project": "", 03:21:34 INFO - "branch": "mozilla-aurora-win32-debug-unittest", 03:21:34 INFO - "changes": [ 03:21:34 INFO - { 03:21:34 INFO - "category": null, 03:21:34 INFO - "files": [ 03:21:34 INFO - { 03:21:34 INFO - "url": null, 03:21:34 INFO - "name": "https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.zip" 03:21:34 INFO - }, 03:21:34 INFO - { 03:21:34 INFO - "url": null, 03:21:34 INFO - "name": "https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/test_packages.json" 03:21:34 INFO - } 03:21:34 INFO - ], 03:21:34 INFO - "repository": "", 03:21:34 INFO - "rev": "41fdefd640f368bccdeafe6446d42c0a5ad22797", 03:21:34 INFO - "who": "jyavenard@mozilla.com", 03:21:34 INFO - "when": 1446113696, 03:21:34 INFO - "number": 6592742, 03:21:34 INFO - "comments": "Bug 1218157: Only ever read from cached data in NotifyDataArrived. r=cpearce a=lizzard\n\nThe logic of queuing NotifyDataArrived and read data there was fundamentally flawed as we would continually perform reads from the same MediaResource at two different ends.\nThis would cause repetitive seeks and data being removed from the media cache. Worse, a read in NotifyDataArrived would cause another NotifyDataArrived to be scheduled.\n\nAs range-request are extremely slow, it would result in stutters and constant interruptions.\n", 03:21:34 INFO - "project": "", 03:21:34 INFO - "at": "Thu 29 Oct 2015 03:14:56", 03:21:34 INFO - "branch": "mozilla-aurora-win32-debug-unittest", 03:21:34 INFO - "revlink": "", 03:21:34 INFO - "properties": [ 03:21:34 INFO - [ 03:21:34 INFO - "buildid", 03:21:34 INFO - "20151029014646", 03:21:34 INFO - "Change" 03:21:34 INFO - ], 03:21:34 INFO - [ 03:21:34 INFO - "builduid", 03:21:34 INFO - "e2197d6fa76745edba8eadefeb37f684", 03:21:34 INFO - "Change" 03:21:34 INFO - ], 03:21:34 INFO - [ 03:21:34 INFO - "pgo_build", 03:21:34 INFO - "False", 03:21:34 INFO - "Change" 03:21:34 INFO - ] 03:21:34 INFO - ], 03:21:34 INFO - "revision": "41fdefd640f368bccdeafe6446d42c0a5ad22797" 03:21:34 INFO - } 03:21:34 INFO - ], 03:21:34 INFO - "revision": "41fdefd640f368bccdeafe6446d42c0a5ad22797" 03:21:34 INFO - } 03:21:34 INFO - } 03:21:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.zip. 03:21:34 INFO - Found a test packages url https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/test_packages.json. 03:21:34 INFO - Running post-action listener: _resource_record_post_action 03:21:34 INFO - ##### 03:21:34 INFO - ##### Running download-and-extract step. 03:21:34 INFO - ##### 03:21:34 INFO - Running pre-action listener: _resource_record_pre_action 03:21:34 INFO - Running main action method: download_and_extract 03:21:34 INFO - mkdir: C:\slave\test\build\tests 03:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:34 INFO - https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:21:34 INFO - trying https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/test_packages.json 03:21:34 INFO - Downloading https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 03:21:34 INFO - retry: Calling _download_file with args: ('https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/test_packages.json', 'C:\\slave\\test\\build\\test_packages.json'), kwargs: {}, attempt #1 03:21:36 INFO - Downloaded 1221 bytes. 03:21:36 INFO - Reading from file C:\slave\test\build\test_packages.json 03:21:36 INFO - Using the following test package requirements: 03:21:36 INFO - {u'common': [u'firefox-43.0a2.en-US.win32.common.tests.zip'], 03:21:36 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.win32.common.tests.zip', 03:21:36 INFO - u'firefox-43.0a2.en-US.win32.cppunittest.tests.zip'], 03:21:36 INFO - u'jittest': [u'firefox-43.0a2.en-US.win32.common.tests.zip', 03:21:36 INFO - u'jsshell-win32.zip'], 03:21:36 INFO - u'mochitest': [u'firefox-43.0a2.en-US.win32.common.tests.zip', 03:21:36 INFO - u'firefox-43.0a2.en-US.win32.mochitest.tests.zip'], 03:21:36 INFO - u'mozbase': [u'firefox-43.0a2.en-US.win32.common.tests.zip'], 03:21:36 INFO - u'reftest': [u'firefox-43.0a2.en-US.win32.common.tests.zip', 03:21:36 INFO - u'firefox-43.0a2.en-US.win32.reftest.tests.zip'], 03:21:36 INFO - u'talos': [u'firefox-43.0a2.en-US.win32.common.tests.zip', 03:21:36 INFO - u'firefox-43.0a2.en-US.win32.talos.tests.zip'], 03:21:36 INFO - u'web-platform': [u'firefox-43.0a2.en-US.win32.common.tests.zip', 03:21:36 INFO - u'firefox-43.0a2.en-US.win32.web-platform.tests.zip'], 03:21:36 INFO - u'webapprt': [u'firefox-43.0a2.en-US.win32.common.tests.zip'], 03:21:36 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.win32.common.tests.zip', 03:21:36 INFO - u'firefox-43.0a2.en-US.win32.xpcshell.tests.zip']} 03:21:36 INFO - Downloading packages: [u'firefox-43.0a2.en-US.win32.common.tests.zip', u'firefox-43.0a2.en-US.win32.reftest.tests.zip'] for test suite category: reftest 03:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:36 INFO - https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 03:21:36 INFO - trying https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.common.tests.zip 03:21:36 INFO - Downloading https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.common.tests.zip to C:\slave\test\build\firefox-43.0a2.en-US.win32.common.tests.zip 03:21:36 INFO - retry: Calling _download_file with args: (u'https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.common.tests.zip', u'C:\\slave\\test\\build\\firefox-43.0a2.en-US.win32.common.tests.zip'), kwargs: {}, attempt #1 03:21:38 INFO - Downloaded 21080050 bytes. 03:21:38 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-43.0a2.en-US.win32.common.tests.zip', 'bin/*', 'certs/*', 'modules/*', 'mozbase/*', 'config/*', 'reftest/*', 'jsreftest/*'] in C:\slave\test\build\tests 03:21:38 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-43.0a2.en-US.win32.common.tests.zip bin/* certs/* modules/* mozbase/* config/* reftest/* jsreftest/* 03:21:38 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-43.0a2.en-US.win32.common.tests.zip', 'bin/*', 'certs/*', 'modules/*', 'mozbase/*', 'config/*', 'reftest/*', 'jsreftest/*'] with output_timeout 1760 03:21:51 INFO - caution: filename not matched: reftest/* 03:21:51 INFO - Return code: 11 03:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:51 INFO - https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.reftest.tests.zip matches https://queue.taskcluster.net 03:21:51 INFO - trying https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.reftest.tests.zip 03:21:51 INFO - Downloading https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.reftest.tests.zip to C:\slave\test\build\firefox-43.0a2.en-US.win32.reftest.tests.zip 03:21:51 INFO - retry: Calling _download_file with args: (u'https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.reftest.tests.zip', u'C:\\slave\\test\\build\\firefox-43.0a2.en-US.win32.reftest.tests.zip'), kwargs: {}, attempt #1 03:21:54 INFO - Downloaded 34811058 bytes. 03:21:54 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-43.0a2.en-US.win32.reftest.tests.zip', 'bin/*', 'certs/*', 'modules/*', 'mozbase/*', 'config/*', 'reftest/*', 'jsreftest/*'] in C:\slave\test\build\tests 03:21:54 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-43.0a2.en-US.win32.reftest.tests.zip bin/* certs/* modules/* mozbase/* config/* reftest/* jsreftest/* 03:21:54 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-43.0a2.en-US.win32.reftest.tests.zip', 'bin/*', 'certs/*', 'modules/*', 'mozbase/*', 'config/*', 'reftest/*', 'jsreftest/*'] with output_timeout 1760 03:22:32 INFO - caution: filename not matched: bin/* 03:22:32 INFO - caution: filename not matched: certs/* 03:22:32 INFO - caution: filename not matched: modules/* 03:22:32 INFO - caution: filename not matched: mozbase/* 03:22:32 INFO - caution: filename not matched: config/* 03:22:32 INFO - caution: filename not matched: jsreftest/* 03:22:32 INFO - Return code: 11 03:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:32 INFO - https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.zip matches https://queue.taskcluster.net 03:22:32 INFO - trying https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.zip 03:22:32 INFO - Downloading https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.zip to C:\slave\test\build\installer.zip 03:22:32 INFO - retry: Calling _download_file with args: ('https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.zip', 'C:\\slave\\test\\build\\installer.zip'), kwargs: {}, attempt #1 03:22:36 INFO - Downloaded 63502245 bytes. 03:22:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.zip 03:22:36 INFO - mkdir: C:\slave\test\properties 03:22:36 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 03:22:36 INFO - Writing to file C:\slave\test\properties\build_url 03:22:36 INFO - Contents: 03:22:36 INFO - build_url:https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.zip 03:22:36 INFO - mkdir: C:\slave\test\build\symbols 03:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:36 INFO - https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.crashreporter-symbols.zip matches https://queue.taskcluster.net 03:22:36 INFO - trying https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.crashreporter-symbols.zip 03:22:36 INFO - Downloading https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.crashreporter-symbols.zip to C:\slave\test\build\symbols\firefox-43.0a2.en-US.win32.crashreporter-symbols.zip 03:22:36 INFO - retry: Calling _download_file with args: ('https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.crashreporter-symbols.zip', 'C:\\slave\\test\\build\\symbols\\firefox-43.0a2.en-US.win32.crashreporter-symbols.zip'), kwargs: {}, attempt #1 03:22:40 INFO - Downloaded 49204938 bytes. 03:22:40 INFO - Setting buildbot property symbols_url to https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.crashreporter-symbols.zip 03:22:40 INFO - Writing buildbot properties ['symbols_url'] to C:\slave\test\properties\symbols_url 03:22:40 INFO - Writing to file C:\slave\test\properties\symbols_url 03:22:40 INFO - Contents: 03:22:40 INFO - symbols_url:https://queue.taskcluster.net/v1/task/_7cEx_yoQm2feKHdVVicdg/artifacts/public/build/firefox-43.0a2.en-US.win32.crashreporter-symbols.zip 03:22:40 INFO - Running command: ['unzip', '-q', 'C:\\slave\\test\\build\\symbols\\firefox-43.0a2.en-US.win32.crashreporter-symbols.zip'] in C:\slave\test\build\symbols 03:22:40 INFO - Copy/paste: unzip -q C:\slave\test\build\symbols\firefox-43.0a2.en-US.win32.crashreporter-symbols.zip 03:22:43 INFO - Return code: 0 03:22:43 INFO - Running post-action listener: _resource_record_post_action 03:22:43 INFO - Running post-action listener: _set_extra_try_arguments 03:22:43 INFO - ##### 03:22:43 INFO - ##### Running create-virtualenv step. 03:22:43 INFO - ##### 03:22:43 INFO - Running pre-action listener: _install_mozbase 03:22:43 INFO - Running pre-action listener: _pre_create_virtualenv 03:22:43 INFO - Running pre-action listener: _resource_record_pre_action 03:22:43 INFO - Running main action method: create_virtualenv 03:22:43 INFO - Creating virtualenv C:\slave\test\build\venv 03:22:43 INFO - mkdir: C:\slave\test\build\venv\Scripts 03:22:43 INFO - Copying c:\mozilla-build\python27\python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 03:22:43 WARNING - Can't copy c:\mozilla-build\python27\python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:\\mozilla-build\\python27\\python27.dll'! 03:22:43 INFO - Running command: ['c:\\mozilla-build\\python27\\python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build\\venv'] in C:\slave\test\build 03:22:43 INFO - Copy/paste: c:\mozilla-build\python27\python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build\venv 03:22:48 INFO - New python executable in C:\slave\test\build\venv\Scripts\python.exe 03:22:53 INFO - Installing distribute......................................................................................................................................................................................done. 03:22:55 INFO - Return code: 0 03:22:55 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build\venv 03:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:55 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build\\venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0178F100>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012DCF20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FBCA0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01825758>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01272C80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0184C660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'MOZILLABUILD': 'D:\\mozilla-build', 'COMPUTERNAME': 'T-W732-IX-123', 'USERDOMAIN': 'T-W732-IX-123', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'LIBPATH': 'C:\\WINDOWS\\Microsoft.NET\\Framework\\v2.0.50727;D:\\msvs8\\VC\\ATLMFC\\LIB', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'MOZILLABUILDPATH': '\\mozilla-build\\', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'MOZ_HIDE_RESULTS_TABLE': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'VCVARS': 'D:\\msvs8\\VC\\bin\\vcvars32.bat', 'VSINSTALLDIR': 'D:\\msvs8', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'MOZILLABUILDDRIVE': 'C:', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'FRAMEWORKDIR': 'C:\\WINDOWS\\Microsoft.NET\\Framework', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'FRAMEWORKSDKDIR': 'D:\\msvs8\\SDK\\v2.0', 'TEST1': 'testie', 'LOGONSERVER': '\\\\T-W732-IX-123', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'MSVCDIR': 'D:\\msvs8\\VC', 'PROGRAMDATA': 'C:\\ProgramData', 'MOZ_TOOLS': 'D:\\mozilla-build\\moztools', '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\\', 'MOZ_AIRBAG': '1', 'PROMPT': '$P$G', 'USERNAME': 'cltbld', 'NO_FAIL_ON_TEST_ERRORS': '1', 'VCINSTALLDIR': 'D:\\msvs8\\VC', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'WINDOWS_TRACING_FLAGS': '3', 'FRAMEWORKVERSION': 'v2.0.50727', 'SYSTEMDRIVE': 'C:', 'MOZ_MSVCVERSION': '8', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'DEVENVDIR': 'D:\\msvs8\\Common7\\IDE', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 03:22:55 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build\\venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in C:\slave\test\build 03:22:55 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build\venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:22:55 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:22:55 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 03:22:55 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 03:22:55 INFO - 'COMPUTERNAME': 'T-W732-IX-123', 03:22:55 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:22:55 INFO - 'DCLOCATION': 'SCL3', 03:22:55 INFO - 'DEVENVDIR': 'D:\\msvs8\\Common7\\IDE', 03:22:55 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:22:55 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:22:55 INFO - 'FRAMEWORKDIR': 'C:\\WINDOWS\\Microsoft.NET\\Framework', 03:22:55 INFO - 'FRAMEWORKSDKDIR': 'D:\\msvs8\\SDK\\v2.0', 03:22:55 INFO - 'FRAMEWORKVERSION': 'v2.0.50727', 03:22:55 INFO - 'HOMEDRIVE': 'C:', 03:22:55 INFO - 'HOMEPATH': '\\Users\\cltbld', 03:22:55 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:22:55 INFO - 'KTS_VERSION': '1.19c', 03:22:55 INFO - 'LIBPATH': 'C:\\WINDOWS\\Microsoft.NET\\Framework\\v2.0.50727;D:\\msvs8\\VC\\ATLMFC\\LIB', 03:22:55 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 03:22:55 INFO - 'LOGONSERVER': '\\\\T-W732-IX-123', 03:22:55 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:22:55 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:22:55 INFO - 'MOZILLABUILD': 'D:\\mozilla-build', 03:22:55 INFO - 'MOZILLABUILDDRIVE': 'C:', 03:22:55 INFO - 'MOZILLABUILDPATH': '\\mozilla-build\\', 03:22:55 INFO - 'MOZ_AIRBAG': '1', 03:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:55 INFO - 'MOZ_HIDE_RESULTS_TABLE': '1', 03:22:55 INFO - 'MOZ_MSVCVERSION': '8', 03:22:55 INFO - 'MOZ_NO_REMOTE': '1', 03:22:55 INFO - 'MOZ_TOOLS': 'D:\\mozilla-build\\moztools', 03:22:55 INFO - 'MSVCDIR': 'D:\\msvs8\\VC', 03:22:55 INFO - 'NO_EM_RESTART': '1', 03:22:55 INFO - 'NO_FAIL_ON_TEST_ERRORS': '1', 03:22:55 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:22:55 INFO - 'OS': 'Windows_NT', 03:22:55 INFO - 'OURDRIVE': 'C:', 03:22:55 INFO - '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\\', 03:22:55 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:22:55 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:22:55 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 03:22:55 INFO - 'PROCESSOR_LEVEL': '6', 03:22:55 INFO - 'PROCESSOR_REVISION': '1e05', 03:22:55 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:22:55 INFO - 'PROGRAMFILES': 'C:\\Program Files', 03:22:55 INFO - 'PROMPT': '$P$G', 03:22:55 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:22:55 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:22:55 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:22:55 INFO - 'PWD': 'C:\\slave\\test', 03:22:55 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:22:55 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:22:55 INFO - 'SYSTEMDRIVE': 'C:', 03:22:55 INFO - 'SYSTEMROOT': 'C:\\windows', 03:22:55 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 03:22:55 INFO - 'TEST1': 'testie', 03:22:55 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 03:22:55 INFO - 'USERDOMAIN': 'T-W732-IX-123', 03:22:55 INFO - 'USERNAME': 'cltbld', 03:22:55 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 03:22:55 INFO - 'VCINSTALLDIR': 'D:\\msvs8\\VC', 03:22:55 INFO - 'VCVARS': 'D:\\msvs8\\VC\\bin\\vcvars32.bat', 03:22:55 INFO - 'VSINSTALLDIR': 'D:\\msvs8', 03:22:55 INFO - 'WINDIR': 'C:\\windows', 03:22:55 INFO - 'WINDOWS_TRACING_FLAGS': '3', 03:22:55 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 03:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:22:56 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:22:56 INFO - Downloading/unpacking psutil>=0.7.1 03:22:56 INFO - Creating supposed download cache at C:\slave\test\build\venv\cache 03:22:57 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpsutil-3.1.1.tar.gz 03:22:57 INFO - Running setup.py egg_info for package psutil 03:22:57 INFO - warning: no previously-included files matching '*' found under directory 'docs\_build' 03:22:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects