builder: mozilla-inbound_win7-ix-debug_test-web-platform-tests-2 slave: t-w732-ix-054 starttime: 1446308122.98 results: success (0) buildid: 20151031062853 builduid: 34f0289975e34a62998aeaa66a0eda1f revision: 91ebb3e569a130c535498e8bbf866ca17de53d1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:22.980782) ========= master: http://buildbot-master126.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:22.981165) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2015-10-31 09:15:22.981464) ========= '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-054 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-054 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\;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-054 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.793000 basedir: 'C:\\slave\\test' ========= master_lag: 1.60 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2015-10-31 09:15:25.370509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:25.370838) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:25.582540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:25.583047) ========= '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-054 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-054 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\;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-054 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 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:25.798585) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:25.798887) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:25.799265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:25.799583) ========= '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-054 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-054 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\;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-054 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 --09:15:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12,141 (12K) [text/x-python] 0K .......... . 100% 2.45 GB/s 09:15:27 (2.45 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.776000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:26.595039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2015-10-31 09:15:26.595879) ========= '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-054 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-054 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\;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-054 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.101000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2015-10-31 09:15:30.719642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-31 09:15:30.720500) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 91ebb3e569a130c535498e8bbf866ca17de53d1d --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 91ebb3e569a130c535498e8bbf866ca17de53d1d --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-054 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-054 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\;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-054 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-31 09:15:31,740 truncating revision to first 12 chars 2015-10-31 09:15:31,740 Setting DEBUG logging. 2015-10-31 09:15:31,740 attempt 1/10 2015-10-31 09:15:31,740 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/91ebb3e569a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-31 09:15:32,203 unpacking tar archive at: mozilla-inbound-91ebb3e569a1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.374000 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-31 09:15:32.189476) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:32.189886) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:32.205916) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:32.206358) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-31 09:15:32.207100) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 40 mins, 25 secs) (at 2015-10-31 09:15:32.207655) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/web_platform_tests.py' '--cfg' 'web_platform_tests/prod_config_windows.py' '--test-type=testharness' '--total-chunks' '8' '--this-chunk' '2' '--blob-upload-branch' 'mozilla-inbound' '--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/web_platform_tests.py', '--cfg', 'web_platform_tests/prod_config_windows.py', '--test-type=testharness', '--total-chunks', '8', '--this-chunk', '2', '--blob-upload-branch', 'mozilla-inbound', '--download-symbols', 'true'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-054 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-054 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\;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-054 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 09:15:33 INFO - MultiFileLogger online at 20151031 09:15:33 in C:\slave\test 09:15:33 INFO - Run as scripts/scripts/web_platform_tests.py --cfg web_platform_tests/prod_config_windows.py --test-type=testharness --total-chunks 8 --this-chunk 2 --blob-upload-branch mozilla-inbound --download-symbols true 09:15:33 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 09:15:33 INFO - {'append_to_log': False, 09:15:33 INFO - 'base_work_dir': 'C:\\slave\\test', 09:15:33 INFO - 'blob_upload_branch': 'mozilla-inbound', 09:15:33 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 09:15:33 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:33 INFO - 'config_files': ('web_platform_tests/prod_config_windows.py',), 09:15:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:33 INFO - 'download_minidump_stackwalk': True, 09:15:33 INFO - 'download_symbols': 'true', 09:15:33 INFO - 'exes': {'hg': 'c:/mozilla-build/hg/hg', 09:15:33 INFO - 'mozinstall': ('C:\\slave\\test/build/venv/scripts/python', 09:15:33 INFO - 'C:\\slave\\test/build/venv/scripts/mozinstall-script.py'), 09:15:33 INFO - 'python': 'c:\\mozilla-build\\python27\\python.exe', 09:15:33 INFO - 'tooltool.py': ('c:\\mozilla-build\\python27\\python.exe', 09:15:33 INFO - 'C:/mozilla-build/tooltool.py'), 09:15:33 INFO - 'virtualenv': ('c:\\mozilla-build\\python27\\python.exe', 09:15:33 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 09:15:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:33 INFO - 'log_level': 'info', 09:15:33 INFO - 'log_to_console': True, 09:15:33 INFO - 'opt_config_files': (), 09:15:33 INFO - 'options': ('--prefs-root=%(test_path)s/prefs', 09:15:33 INFO - '--processes=1', 09:15:33 INFO - '--config=%(test_path)s/wptrunner.ini', 09:15:33 INFO - '--ca-cert-path=%(test_path)s/certs/cacert.pem', 09:15:33 INFO - '--host-key-path=%(test_path)s/certs/web-platform.test.key', 09:15:33 INFO - '--host-cert-path=%(test_path)s/certs/web-platform.test.pem', 09:15:33 INFO - '--certutil-binary=%(test_install_path)s/bin/certutil'), 09:15:33 INFO - 'pip_index': False, 09:15:33 INFO - 'require_test_zip': True, 09:15:33 INFO - 'test_type': ('testharness',), 09:15:33 INFO - 'this_chunk': '2', 09:15:33 INFO - 'total_chunks': '8', 09:15:33 INFO - 'virtualenv_path': 'venv', 09:15:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:33 INFO - 'work_dir': 'build'} 09:15:33 INFO - ##### 09:15:33 INFO - ##### Running clobber step. 09:15:33 INFO - ##### 09:15:33 INFO - Running pre-action listener: _resource_record_pre_action 09:15:33 INFO - Running main action method: clobber 09:15:33 INFO - rmtree: C:\slave\test\build 09:15:33 INFO - Using _rmtree_windows ... 09:15:33 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 09:17:03 INFO - Running post-action listener: _resource_record_post_action 09:17:03 INFO - ##### 09:17:03 INFO - ##### Running read-buildbot-config step. 09:17:03 INFO - ##### 09:17:03 INFO - Running pre-action listener: _resource_record_pre_action 09:17:03 INFO - Running main action method: read_buildbot_config 09:17:03 INFO - Using buildbot properties: 09:17:03 INFO - { 09:17:03 INFO - "properties": { 09:17:03 INFO - "buildnumber": 4, 09:17:03 INFO - "product": "firefox", 09:17:03 INFO - "script_repo_revision": "production", 09:17:03 INFO - "branch": "mozilla-inbound", 09:17:03 INFO - "repository": "", 09:17:03 INFO - "buildername": "Windows 7 32-bit mozilla-inbound debug test web-platform-tests-2", 09:17:03 INFO - "buildid": "20151031062853", 09:17:03 INFO - "slavename": "t-w732-ix-054", 09:17:03 INFO - "pgo_build": "False", 09:17:03 INFO - "basedir": "C:\\slave\\test", 09:17:03 INFO - "project": "", 09:17:03 INFO - "platform": "win32", 09:17:03 INFO - "master": "http://buildbot-master126.bb.releng.scl3.mozilla.com:8201/", 09:17:03 INFO - "slavebuilddir": "test", 09:17:03 INFO - "scheduler": "tests-mozilla-inbound-win7-ix-debug-unittest-7-3600", 09:17:03 INFO - "repo_path": "integration/mozilla-inbound", 09:17:03 INFO - "moz_repo_path": "", 09:17:03 INFO - "stage_platform": "win32", 09:17:03 INFO - "builduid": "34f0289975e34a62998aeaa66a0eda1f", 09:17:03 INFO - "revision": "91ebb3e569a130c535498e8bbf866ca17de53d1d" 09:17:03 INFO - }, 09:17:03 INFO - "sourcestamp": { 09:17:03 INFO - "repository": "", 09:17:03 INFO - "hasPatch": false, 09:17:03 INFO - "project": "", 09:17:03 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 09:17:03 INFO - "changes": [ 09:17:03 INFO - { 09:17:03 INFO - "category": null, 09:17:03 INFO - "files": [ 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/GrffYaZHQDKy6gh_YV9tkg/artifacts/public/build/firefox-45.0a1.en-US.win32.zip" 09:17:03 INFO - }, 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/GrffYaZHQDKy6gh_YV9tkg/artifacts/public/build/test_packages.json" 09:17:03 INFO - } 09:17:03 INFO - ], 09:17:03 INFO - "repository": "", 09:17:03 INFO - "rev": "2638fcfb3217dbe24b1052fa2f44335d44ef5de5", 09:17:03 INFO - "who": "lhansen@mozilla.com", 09:17:03 INFO - "when": 1446294669, 09:17:03 INFO - "number": 6604202, 09:17:03 INFO - "comments": "Bug 1094150 - make jitspew available in release builds. r=nbp", 09:17:03 INFO - "project": "", 09:17:03 INFO - "at": "Sat 31 Oct 2015 05:31:09", 09:17:03 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 09:17:03 INFO - "revlink": "", 09:17:03 INFO - "properties": [ 09:17:03 INFO - [ 09:17:03 INFO - "buildid", 09:17:03 INFO - "20151031034753", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "builduid", 09:17:03 INFO - "e182ec40fad44726904bc559d34e75d6", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "pgo_build", 09:17:03 INFO - "False", 09:17:03 INFO - "Change" 09:17:03 INFO - ] 09:17:03 INFO - ], 09:17:03 INFO - "revision": "2638fcfb3217dbe24b1052fa2f44335d44ef5de5" 09:17:03 INFO - }, 09:17:03 INFO - { 09:17:03 INFO - "category": null, 09:17:03 INFO - "files": [ 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/Mn7K7SVXRzyMQHYyGtHMVQ/artifacts/public/build/firefox-45.0a1.en-US.win32.zip" 09:17:03 INFO - }, 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/Mn7K7SVXRzyMQHYyGtHMVQ/artifacts/public/build/test_packages.json" 09:17:03 INFO - } 09:17:03 INFO - ], 09:17:03 INFO - "repository": "", 09:17:03 INFO - "rev": "ea8093d8be6ad31ab2cb5a68022b77a9fed6264d", 09:17:03 INFO - "who": "nfroyd@mozilla.com", 09:17:03 INFO - "when": 1446297705, 09:17:03 INFO - "number": 6604275, 09:17:03 INFO - "comments": "Bug 1197313 - remove PR_snprintf calls in netwerk/; r=froydnj", 09:17:03 INFO - "project": "", 09:17:03 INFO - "at": "Sat 31 Oct 2015 06:21:45", 09:17:03 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 09:17:03 INFO - "revlink": "", 09:17:03 INFO - "properties": [ 09:17:03 INFO - [ 09:17:03 INFO - "buildid", 09:17:03 INFO - "20151031045601", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "builduid", 09:17:03 INFO - "a5246e3a328046a0a7d7adceae90d075", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "pgo_build", 09:17:03 INFO - "False", 09:17:03 INFO - "Change" 09:17:03 INFO - ] 09:17:03 INFO - ], 09:17:03 INFO - "revision": "ea8093d8be6ad31ab2cb5a68022b77a9fed6264d" 09:17:03 INFO - }, 09:17:03 INFO - { 09:17:03 INFO - "category": null, 09:17:03 INFO - "files": [ 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/U6rguMKtR-uZolxSVeFCHA/artifacts/public/build/firefox-45.0a1.en-US.win32.zip" 09:17:03 INFO - }, 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/U6rguMKtR-uZolxSVeFCHA/artifacts/public/build/test_packages.json" 09:17:03 INFO - } 09:17:03 INFO - ], 09:17:03 INFO - "repository": "", 09:17:03 INFO - "rev": "a1a2ce2eafa9d6a325a384e47fda68e564ff0b00", 09:17:03 INFO - "who": "arai_a@mac.com", 09:17:03 INFO - "when": 1446300247, 09:17:03 INFO - "number": 6604357, 09:17:03 INFO - "comments": "Bug 1217981 - Part 3: Remove for-each from testing/. r=bsmedberg", 09:17:03 INFO - "project": "", 09:17:03 INFO - "at": "Sat 31 Oct 2015 07:04:07", 09:17:03 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 09:17:03 INFO - "revlink": "", 09:17:03 INFO - "properties": [ 09:17:03 INFO - [ 09:17:03 INFO - "buildid", 09:17:03 INFO - "20151031052953", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "builduid", 09:17:03 INFO - "dec00637d22a4c198f83208ac2805b81", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "pgo_build", 09:17:03 INFO - "False", 09:17:03 INFO - "Change" 09:17:03 INFO - ] 09:17:03 INFO - ], 09:17:03 INFO - "revision": "a1a2ce2eafa9d6a325a384e47fda68e564ff0b00" 09:17:03 INFO - }, 09:17:03 INFO - { 09:17:03 INFO - "category": null, 09:17:03 INFO - "files": [ 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/mdMUTmHQTKeNKpi7Qo2uJQ/artifacts/public/build/firefox-45.0a1.en-US.win32.zip" 09:17:03 INFO - }, 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/mdMUTmHQTKeNKpi7Qo2uJQ/artifacts/public/build/test_packages.json" 09:17:03 INFO - } 09:17:03 INFO - ], 09:17:03 INFO - "repository": "", 09:17:03 INFO - "rev": "5649b6b8cec386092fea92be17d0963050ffc1f7", 09:17:03 INFO - "who": "nfroyd@mozilla.com", 09:17:03 INFO - "when": 1446303929, 09:17:03 INFO - "number": 6604431, 09:17:03 INFO - "comments": "Bug 1219246 - use UniquePtr instead of nsAutoArrayPtr in xpcom/; r=erahm", 09:17:03 INFO - "project": "", 09:17:03 INFO - "at": "Sat 31 Oct 2015 08:05:29", 09:17:03 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 09:17:03 INFO - "revlink": "", 09:17:03 INFO - "properties": [ 09:17:03 INFO - [ 09:17:03 INFO - "buildid", 09:17:03 INFO - "20151031060553", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "builduid", 09:17:03 INFO - "f0fa7bcd70ea4e5d89a6d425ffa337d6", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "pgo_build", 09:17:03 INFO - "False", 09:17:03 INFO - "Change" 09:17:03 INFO - ] 09:17:03 INFO - ], 09:17:03 INFO - "revision": "5649b6b8cec386092fea92be17d0963050ffc1f7" 09:17:03 INFO - }, 09:17:03 INFO - { 09:17:03 INFO - "category": null, 09:17:03 INFO - "files": [ 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/YRwipEERRQC6S-8QUhVDAA/artifacts/public/build/firefox-45.0a1.en-US.win32.zip" 09:17:03 INFO - }, 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/YRwipEERRQC6S-8QUhVDAA/artifacts/public/build/test_packages.json" 09:17:03 INFO - } 09:17:03 INFO - ], 09:17:03 INFO - "repository": "", 09:17:03 INFO - "rev": "75b33ded527144554638530abad1b87a1a051580", 09:17:03 INFO - "who": "r@hev.cc", 09:17:03 INFO - "when": 1446302943, 09:17:03 INFO - "number": 6604407, 09:17:03 INFO - "comments": "Bug 1213146 - IonMonkey: MIPS: Move Assembler::PatchDataWithValueCheck to architecture specific. r=lth\n\n---\n js/src/jit/mips-shared/Assembler-mips-shared.cpp | 7 -------\n js/src/jit/mips-shared/Assembler-mips-shared.h | 2 --\n js/src/jit/mips32/Assembler-mips32.cpp | 8 ++++++++\n js/src/jit/mips32/Assembler-mips32.h | 3 ++-\n js/src/jit/mips64/Assembler-mips64.cpp | 8 ++++++++\n js/src/jit/mips64/Assembler-mips64.h | 3 ++-\n 6 files changed, 20 insertions(+), 11 deletions(-)", 09:17:03 INFO - "project": "", 09:17:03 INFO - "at": "Sat 31 Oct 2015 07:49:03", 09:17:03 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 09:17:03 INFO - "revlink": "", 09:17:03 INFO - "properties": [ 09:17:03 INFO - [ 09:17:03 INFO - "buildid", 09:17:03 INFO - "20151031061154", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "builduid", 09:17:03 INFO - "a94aa1eb457f4de1806577a7a017dd33", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "pgo_build", 09:17:03 INFO - "False", 09:17:03 INFO - "Change" 09:17:03 INFO - ] 09:17:03 INFO - ], 09:17:03 INFO - "revision": "75b33ded527144554638530abad1b87a1a051580" 09:17:03 INFO - }, 09:17:03 INFO - { 09:17:03 INFO - "category": null, 09:17:03 INFO - "files": [ 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.zip" 09:17:03 INFO - }, 09:17:03 INFO - { 09:17:03 INFO - "url": null, 09:17:03 INFO - "name": "https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/test_packages.json" 09:17:03 INFO - } 09:17:03 INFO - ], 09:17:03 INFO - "repository": "", 09:17:03 INFO - "rev": "91ebb3e569a130c535498e8bbf866ca17de53d1d", 09:17:03 INFO - "who": "amccreight@mozilla.com", 09:17:03 INFO - "when": 1446304381, 09:17:03 INFO - "number": 6604442, 09:17:03 INFO - "comments": "Bug 1219842 - Enable a bunch of mochitest-plain tests under e10s. r=mrbkap", 09:17:03 INFO - "project": "", 09:17:03 INFO - "at": "Sat 31 Oct 2015 08:13:01", 09:17:03 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 09:17:03 INFO - "revlink": "", 09:17:03 INFO - "properties": [ 09:17:03 INFO - [ 09:17:03 INFO - "buildid", 09:17:03 INFO - "20151031062853", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "builduid", 09:17:03 INFO - "34f0289975e34a62998aeaa66a0eda1f", 09:17:03 INFO - "Change" 09:17:03 INFO - ], 09:17:03 INFO - [ 09:17:03 INFO - "pgo_build", 09:17:03 INFO - "False", 09:17:03 INFO - "Change" 09:17:03 INFO - ] 09:17:03 INFO - ], 09:17:03 INFO - "revision": "91ebb3e569a130c535498e8bbf866ca17de53d1d" 09:17:03 INFO - } 09:17:03 INFO - ], 09:17:03 INFO - "revision": "91ebb3e569a130c535498e8bbf866ca17de53d1d" 09:17:03 INFO - } 09:17:03 INFO - } 09:17:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.zip. 09:17:03 INFO - Found a test packages url https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/test_packages.json. 09:17:03 INFO - Running post-action listener: _resource_record_post_action 09:17:03 INFO - ##### 09:17:03 INFO - ##### Running download-and-extract step. 09:17:03 INFO - ##### 09:17:03 INFO - Running pre-action listener: _resource_record_pre_action 09:17:03 INFO - Running main action method: download_and_extract 09:17:03 INFO - mkdir: C:\slave\test\build\tests 09:17:03 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')]} 09:17:03 INFO - https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:17:03 INFO - trying https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/test_packages.json 09:17:03 INFO - Downloading https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 09:17:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1 09:17:04 INFO - Downloaded 1221 bytes. 09:17:04 INFO - Reading from file C:\slave\test\build\test_packages.json 09:17:04 INFO - Using the following test package requirements: 09:17:04 INFO - {u'common': [u'firefox-45.0a1.en-US.win32.common.tests.zip'], 09:17:04 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 09:17:04 INFO - u'firefox-45.0a1.en-US.win32.cppunittest.tests.zip'], 09:17:04 INFO - u'jittest': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 09:17:04 INFO - u'jsshell-win32.zip'], 09:17:04 INFO - u'mochitest': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 09:17:04 INFO - u'firefox-45.0a1.en-US.win32.mochitest.tests.zip'], 09:17:04 INFO - u'mozbase': [u'firefox-45.0a1.en-US.win32.common.tests.zip'], 09:17:04 INFO - u'reftest': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 09:17:04 INFO - u'firefox-45.0a1.en-US.win32.reftest.tests.zip'], 09:17:04 INFO - u'talos': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 09:17:04 INFO - u'firefox-45.0a1.en-US.win32.talos.tests.zip'], 09:17:04 INFO - u'web-platform': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 09:17:04 INFO - u'firefox-45.0a1.en-US.win32.web-platform.tests.zip'], 09:17:04 INFO - u'webapprt': [u'firefox-45.0a1.en-US.win32.common.tests.zip'], 09:17:04 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 09:17:04 INFO - u'firefox-45.0a1.en-US.win32.xpcshell.tests.zip']} 09:17:04 INFO - Downloading packages: [u'firefox-45.0a1.en-US.win32.common.tests.zip', u'firefox-45.0a1.en-US.win32.web-platform.tests.zip'] for test suite category: web-platform 09:17:04 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')]} 09:17:04 INFO - https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 09:17:04 INFO - trying https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.common.tests.zip 09:17:04 INFO - Downloading https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.common.tests.zip to C:\slave\test\build\firefox-45.0a1.en-US.win32.common.tests.zip 09:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win32.common.tests.zip'}, attempt #1 09:17:05 INFO - Downloaded 19142909 bytes. 09:17:05 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win32.common.tests.zip', 'bin/*', 'config/*', 'mozbase/*', 'marionette/*', 'web-platform/*'] in C:\slave\test\build\tests 09:17:05 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-45.0a1.en-US.win32.common.tests.zip bin/* config/* mozbase/* marionette/* web-platform/* 09:17:05 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win32.common.tests.zip', 'bin/*', 'config/*', 'mozbase/*', 'marionette/*', 'web-platform/*'] with output_timeout 1760 09:17:07 INFO - caution: filename not matched: web-platform/* 09:17:07 INFO - Return code: 11 09:17:07 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')]} 09:17:07 INFO - https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.web-platform.tests.zip matches https://queue.taskcluster.net 09:17:07 INFO - trying https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.web-platform.tests.zip 09:17:07 INFO - Downloading https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.web-platform.tests.zip to C:\slave\test\build\firefox-45.0a1.en-US.win32.web-platform.tests.zip 09:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.web-platform.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win32.web-platform.tests.zip'}, attempt #1 09:17:09 INFO - Downloaded 30910417 bytes. 09:17:09 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win32.web-platform.tests.zip', 'bin/*', 'config/*', 'mozbase/*', 'marionette/*', 'web-platform/*'] in C:\slave\test\build\tests 09:17:09 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-45.0a1.en-US.win32.web-platform.tests.zip bin/* config/* mozbase/* marionette/* web-platform/* 09:17:09 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win32.web-platform.tests.zip', 'bin/*', 'config/*', 'mozbase/*', 'marionette/*', 'web-platform/*'] with output_timeout 1760 09:17:46 INFO - caution: filename not matched: bin/* 09:17:46 INFO - caution: filename not matched: config/* 09:17:46 INFO - caution: filename not matched: mozbase/* 09:17:46 INFO - caution: filename not matched: marionette/* 09:17:46 INFO - Return code: 11 09:17:46 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')]} 09:17:46 INFO - https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.zip matches https://queue.taskcluster.net 09:17:46 INFO - trying https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.zip 09:17:46 INFO - Downloading https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.zip to C:\slave\test\build\firefox-45.0a1.en-US.win32.zip 09:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win32.zip'}, attempt #1 09:17:50 INFO - Downloaded 64743844 bytes. 09:17:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.zip 09:17:50 INFO - mkdir: C:\slave\test\properties 09:17:50 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 09:17:50 INFO - Writing to file C:\slave\test\properties\build_url 09:17:50 INFO - Contents: 09:17:50 INFO - build_url:https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.zip 09:17:50 INFO - mkdir: C:\slave\test\build\symbols 09:17:50 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')]} 09:17:50 INFO - https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.crashreporter-symbols.zip matches https://queue.taskcluster.net 09:17:50 INFO - trying https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.crashreporter-symbols.zip 09:17:50 INFO - Downloading https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.crashreporter-symbols.zip to C:\slave\test\build\symbols\firefox-45.0a1.en-US.win32.crashreporter-symbols.zip 09:17:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.crashreporter-symbols.zip', 'file_name': 'C:\\slave\\test\\build\\symbols\\firefox-45.0a1.en-US.win32.crashreporter-symbols.zip'}, attempt #1 09:17:54 INFO - Downloaded 52304731 bytes. 09:17:54 INFO - Setting buildbot property symbols_url to https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.crashreporter-symbols.zip 09:17:54 INFO - Writing buildbot properties ['symbols_url'] to C:\slave\test\properties\symbols_url 09:17:54 INFO - Writing to file C:\slave\test\properties\symbols_url 09:17:54 INFO - Contents: 09:17:54 INFO - symbols_url:https://queue.taskcluster.net/v1/task/XubTnU3pTKS3ItWbTKLvyg/artifacts/public/build/firefox-45.0a1.en-US.win32.crashreporter-symbols.zip 09:17:54 INFO - Running command: ['unzip', '-q', 'C:\\slave\\test\\build\\symbols\\firefox-45.0a1.en-US.win32.crashreporter-symbols.zip'] in C:\slave\test\build\symbols 09:17:54 INFO - Copy/paste: unzip -q C:\slave\test\build\symbols\firefox-45.0a1.en-US.win32.crashreporter-symbols.zip 09:17:56 INFO - Return code: 0 09:17:56 INFO - Running post-action listener: _resource_record_post_action 09:17:56 INFO - Running post-action listener: set_extra_try_arguments 09:17:56 INFO - ##### 09:17:56 INFO - ##### Running create-virtualenv step. 09:17:56 INFO - ##### 09:17:56 INFO - Running pre-action listener: _pre_create_virtualenv 09:17:56 INFO - Running pre-action listener: _resource_record_pre_action 09:17:56 INFO - Running main action method: create_virtualenv 09:17:56 INFO - Creating virtualenv C:\slave\test\build\venv 09:17:56 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 09:17:56 INFO - Copy/paste: c:\mozilla-build\python27\python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build\venv 09:18:03 INFO - New python executable in C:\slave\test\build\venv\Scripts\python.exe 09:18:07 INFO - Installing distribute......................................................................................................................................................................................done. 09:18:09 INFO - Return code: 0 09:18:09 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build\venv 09:18:09 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')]} 09:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:09 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')]} 09:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:09 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 0x01C326B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D4D2F0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01CF94F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D0D2C0>, '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 0x0190AD30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01394E80>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'MOZILLABUILD': 'D:\\mozilla-build', 'COMPUTERNAME': 'T-W732-IX-054', 'USERDOMAIN': 'T-W732-IX-054', '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-054', '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\\;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 09:18:09 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 09:18:09 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 09:18:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:18:09 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 09:18:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 09:18:09 INFO - 'COMPUTERNAME': 'T-W732-IX-054', 09:18:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:18:09 INFO - 'DCLOCATION': 'SCL3', 09:18:09 INFO - 'DEVENVDIR': 'D:\\msvs8\\Common7\\IDE', 09:18:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:18:09 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:18:09 INFO - 'FRAMEWORKDIR': 'C:\\WINDOWS\\Microsoft.NET\\Framework', 09:18:09 INFO - 'FRAMEWORKSDKDIR': 'D:\\msvs8\\SDK\\v2.0', 09:18:09 INFO - 'FRAMEWORKVERSION': 'v2.0.50727', 09:18:09 INFO - 'HOMEDRIVE': 'C:', 09:18:09 INFO - 'HOMEPATH': '\\Users\\cltbld', 09:18:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:18:09 INFO - 'KTS_VERSION': '1.19c', 09:18:09 INFO - 'LIBPATH': 'C:\\WINDOWS\\Microsoft.NET\\Framework\\v2.0.50727;D:\\msvs8\\VC\\ATLMFC\\LIB', 09:18:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 09:18:09 INFO - 'LOGONSERVER': '\\\\T-W732-IX-054', 09:18:09 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:18:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:18:09 INFO - 'MOZILLABUILD': 'D:\\mozilla-build', 09:18:09 INFO - 'MOZILLABUILDDRIVE': 'C:', 09:18:09 INFO - 'MOZILLABUILDPATH': '\\mozilla-build\\', 09:18:09 INFO - 'MOZ_AIRBAG': '1', 09:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:09 INFO - 'MOZ_HIDE_RESULTS_TABLE': '1', 09:18:09 INFO - 'MOZ_MSVCVERSION': '8', 09:18:09 INFO - 'MOZ_NO_REMOTE': '1', 09:18:09 INFO - 'MOZ_TOOLS': 'D:\\mozilla-build\\moztools', 09:18:09 INFO - 'MSVCDIR': 'D:\\msvs8\\VC', 09:18:09 INFO - 'NO_EM_RESTART': '1', 09:18:09 INFO - 'NO_FAIL_ON_TEST_ERRORS': '1', 09:18:09 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:18:09 INFO - 'OS': 'Windows_NT', 09:18:09 INFO - 'OURDRIVE': 'C:', 09:18:09 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\\;C:\\mozilla-build\\hg', 09:18:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:18:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:18:09 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 09:18:09 INFO - 'PROCESSOR_LEVEL': '6', 09:18:09 INFO - 'PROCESSOR_REVISION': '1e05', 09:18:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:18:09 INFO - 'PROGRAMFILES': 'C:\\Program Files', 09:18:09 INFO - 'PROMPT': '$P$G', 09:18:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:18:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:18:09 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:18:09 INFO - 'PWD': 'C:\\slave\\test', 09:18:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:18:09 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:18:09 INFO - 'SYSTEMDRIVE': 'C:', 09:18:09 INFO - 'SYSTEMROOT': 'C:\\windows', 09:18:09 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 09:18:09 INFO - 'TEST1': 'testie', 09:18:09 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 09:18:09 INFO - 'USERDOMAIN': 'T-W732-IX-054', 09:18:09 INFO - 'USERNAME': 'cltbld', 09:18:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 09:18:09 INFO - 'VCINSTALLDIR': 'D:\\msvs8\\VC', 09:18:09 INFO - 'VCVARS': 'D:\\msvs8\\VC\\bin\\vcvars32.bat', 09:18:09 INFO - 'VSINSTALLDIR': 'D:\\msvs8', 09:18:09 INFO - 'WINDIR': 'C:\\windows', 09:18:09 INFO - 'WINDOWS_TRACING_FLAGS': '3', 09:18:09 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 09:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:18:10 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:18:10 INFO - Downloading/unpacking psutil>=0.7.1 09:18:10 INFO - Creating supposed download cache at C:\slave\test\build\venv\cache 09:18:11 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 09:18:11 INFO - Running setup.py egg_info for package psutil 09:18:11 INFO - warning: no previously-included files matching '*' found under directory 'docs\_build' 09:18:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects