builder: mozilla-inbound_win7-ix-debug_test-web-platform-tests-8 slave: t-w732-ix-098 starttime: 1448504627.39 results: exception (4) buildid: 20151125154013 builduid: 00cf3b29d7ef47808067e3bcbd20e732 revision: 27b37512f3f39dbbcad74b913e9ac5e88451550d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:47.386076) ========= master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:47.386458) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:47.386753) ========= '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-098 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-098 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-098 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.528000 basedir: 'C:\\slave\\test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:47.951363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:47.951665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:48.088636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:48.088909) ========= '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-098 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-098 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-098 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-11-25 18:23:48.303922) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:48.304267) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:48.304756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:48.305039) ========= '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-098 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-098 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-098 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log using PTY: False --18:23:48-- 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% 2.10 GB/s 18:23:49 (2.10 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.675000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:48.998625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-11-25 18:23:48.998917) ========= '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-098 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-098 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-098 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=3.801000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-11-25 18:23:52.817341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 18:23:52.817682) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 27b37512f3f39dbbcad74b913e9ac5e88451550d --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 27b37512f3f39dbbcad74b913e9ac5e88451550d --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-098 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-098 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-098 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-11-25 18:23:53,483 truncating revision to first 12 chars 2015-11-25 18:23:53,483 Setting DEBUG logging. 2015-11-25 18:23:53,483 attempt 1/10 2015-11-25 18:23:53,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/27b37512f3f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 18:23:53,951 unpacking tar archive at: mozilla-inbound-27b37512f3f3/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-11-25 18:23:54.278919) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:54.279344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:54.294755) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:54.295114) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 18:23:54.295575) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' exception (results: 4, elapsed: 7 mins, 38 secs) (at 2015-11-25 18:23:54.295908) ========= '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' '8' '--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', '8', '--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-098 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-098 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-098 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 18:23:54 INFO - MultiFileLogger online at 20151125 18:23:54 in C:\slave\test 18:23:54 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 8 --blob-upload-branch mozilla-inbound --download-symbols true 18:23:54 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 18:23:54 INFO - {'append_to_log': False, 18:23:54 INFO - 'base_work_dir': 'C:\\slave\\test', 18:23:54 INFO - 'blob_upload_branch': 'mozilla-inbound', 18:23:54 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 18:23:54 INFO - 'buildbot_json_path': 'buildprops.json', 18:23:54 INFO - 'config_files': ('web_platform_tests/prod_config_windows.py',), 18:23:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:23:54 INFO - 'download_minidump_stackwalk': True, 18:23:54 INFO - 'download_symbols': 'true', 18:23:54 INFO - 'exes': {'hg': 'c:/mozilla-build/hg/hg', 18:23:54 INFO - 'mozinstall': ('C:\\slave\\test/build/venv/scripts/python', 18:23:54 INFO - 'C:\\slave\\test/build/venv/scripts/mozinstall-script.py'), 18:23:54 INFO - 'python': 'c:\\mozilla-build\\python27\\python.exe', 18:23:54 INFO - 'tooltool.py': ('c:\\mozilla-build\\python27\\python.exe', 18:23:54 INFO - 'C:/mozilla-build/tooltool.py'), 18:23:54 INFO - 'virtualenv': ('c:\\mozilla-build\\python27\\python.exe', 18:23:54 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 18:23:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:23:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:23:54 INFO - 'log_level': 'info', 18:23:54 INFO - 'log_to_console': True, 18:23:54 INFO - 'opt_config_files': (), 18:23:54 INFO - 'options': ('--prefs-root=%(test_path)s/prefs', 18:23:54 INFO - '--processes=1', 18:23:54 INFO - '--config=%(test_path)s/wptrunner.ini', 18:23:54 INFO - '--ca-cert-path=%(test_path)s/certs/cacert.pem', 18:23:54 INFO - '--host-key-path=%(test_path)s/certs/web-platform.test.key', 18:23:54 INFO - '--host-cert-path=%(test_path)s/certs/web-platform.test.pem', 18:23:54 INFO - '--certutil-binary=%(test_install_path)s/bin/certutil'), 18:23:54 INFO - 'pip_index': False, 18:23:54 INFO - 'require_test_zip': True, 18:23:54 INFO - 'test_type': ('testharness',), 18:23:54 INFO - 'this_chunk': '8', 18:23:54 INFO - 'total_chunks': '8', 18:23:54 INFO - 'virtualenv_path': 'venv', 18:23:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:23:54 INFO - 'work_dir': 'build'} 18:23:54 INFO - ##### 18:23:54 INFO - ##### Running clobber step. 18:23:54 INFO - ##### 18:23:54 INFO - Running pre-action listener: _resource_record_pre_action 18:23:54 INFO - Running main action method: clobber 18:23:54 INFO - rmtree: C:\slave\test\build 18:23:54 INFO - Using _rmtree_windows ... 18:23:54 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 18:27:00 INFO - Running post-action listener: _resource_record_post_action 18:27:00 INFO - ##### 18:27:00 INFO - ##### Running read-buildbot-config step. 18:27:00 INFO - ##### 18:27:00 INFO - Running pre-action listener: _resource_record_pre_action 18:27:00 INFO - Running main action method: read_buildbot_config 18:27:00 INFO - Using buildbot properties: 18:27:00 INFO - { 18:27:00 INFO - "properties": { 18:27:00 INFO - "buildnumber": 315, 18:27:00 INFO - "product": "firefox", 18:27:00 INFO - "script_repo_revision": "production", 18:27:00 INFO - "branch": "mozilla-inbound", 18:27:00 INFO - "repository": "", 18:27:00 INFO - "buildername": "Windows 7 32-bit mozilla-inbound debug test web-platform-tests-8", 18:27:00 INFO - "buildid": "20151125154013", 18:27:00 INFO - "slavename": "t-w732-ix-098", 18:27:00 INFO - "pgo_build": "False", 18:27:00 INFO - "basedir": "C:\\slave\\test", 18:27:00 INFO - "project": "", 18:27:00 INFO - "platform": "win32", 18:27:00 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/", 18:27:00 INFO - "slavebuilddir": "test", 18:27:00 INFO - "scheduler": "tests-mozilla-inbound-win7-ix-debug-unittest-7-3600", 18:27:00 INFO - "repo_path": "integration/mozilla-inbound", 18:27:00 INFO - "moz_repo_path": "", 18:27:00 INFO - "stage_platform": "win32", 18:27:00 INFO - "builduid": "00cf3b29d7ef47808067e3bcbd20e732", 18:27:00 INFO - "revision": "27b37512f3f39dbbcad74b913e9ac5e88451550d" 18:27:00 INFO - }, 18:27:00 INFO - "sourcestamp": { 18:27:00 INFO - "repository": "", 18:27:00 INFO - "hasPatch": false, 18:27:00 INFO - "project": "", 18:27:00 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 18:27:00 INFO - "changes": [ 18:27:00 INFO - { 18:27:00 INFO - "category": null, 18:27:00 INFO - "files": [ 18:27:00 INFO - { 18:27:00 INFO - "url": null, 18:27:00 INFO - "name": "https://queue.taskcluster.net/v1/task/RBokPybKTcOs4hgPhpiSjA/artifacts/public/build/firefox-45.0a1.en-US.win32.zip" 18:27:00 INFO - }, 18:27:00 INFO - { 18:27:00 INFO - "url": null, 18:27:00 INFO - "name": "https://queue.taskcluster.net/v1/task/RBokPybKTcOs4hgPhpiSjA/artifacts/public/build/test_packages.json" 18:27:00 INFO - } 18:27:00 INFO - ], 18:27:00 INFO - "repository": "", 18:27:00 INFO - "rev": "6fad1abcf96bacda4533e3d2a2512bd4b41fb84e", 18:27:00 INFO - "who": "nthomas@mozilla.com", 18:27:00 INFO - "when": 1448496075, 18:27:00 INFO - "number": 6708345, 18:27:00 INFO - "comments": "Bug 1222227, upload public b2g files to S3 system, temporarily disables socorro and source manifest uploads, r=catlee CLOSED TREE", 18:27:00 INFO - "project": "", 18:27:00 INFO - "at": "Wed 25 Nov 2015 16:01:15", 18:27:00 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 18:27:00 INFO - "revlink": "", 18:27:00 INFO - "properties": [ 18:27:00 INFO - [ 18:27:00 INFO - "buildid", 18:27:00 INFO - "20151125141110", 18:27:00 INFO - "Change" 18:27:00 INFO - ], 18:27:00 INFO - [ 18:27:00 INFO - "builduid", 18:27:00 INFO - "b592c27dd29f4235a456546d561f0fe7", 18:27:00 INFO - "Change" 18:27:00 INFO - ], 18:27:00 INFO - [ 18:27:00 INFO - "pgo_build", 18:27:00 INFO - "False", 18:27:00 INFO - "Change" 18:27:00 INFO - ] 18:27:00 INFO - ], 18:27:00 INFO - "revision": "6fad1abcf96bacda4533e3d2a2512bd4b41fb84e" 18:27:00 INFO - }, 18:27:00 INFO - { 18:27:00 INFO - "category": null, 18:27:00 INFO - "files": [ 18:27:00 INFO - { 18:27:00 INFO - "url": null, 18:27:00 INFO - "name": "https://queue.taskcluster.net/v1/task/xHap94CBRyyDNY2SciKaCA/artifacts/public/build/firefox-45.0a1.en-US.win32.zip" 18:27:00 INFO - }, 18:27:00 INFO - { 18:27:00 INFO - "url": null, 18:27:00 INFO - "name": "https://queue.taskcluster.net/v1/task/xHap94CBRyyDNY2SciKaCA/artifacts/public/build/test_packages.json" 18:27:00 INFO - } 18:27:00 INFO - ], 18:27:00 INFO - "repository": "", 18:27:00 INFO - "rev": "9350db7159542bb6a37351d39390f64ff95faa43", 18:27:00 INFO - "who": "amccreight@mozilla.com", 18:27:00 INFO - "when": 1448497852, 18:27:00 INFO - "number": 6708507, 18:27:00 INFO - "comments": "Bug 1226291 - disable test on Android in the proper way. r=bustage\nCLOSED TREE", 18:27:00 INFO - "project": "", 18:27:00 INFO - "at": "Wed 25 Nov 2015 16:30:52", 18:27:00 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 18:27:00 INFO - "revlink": "", 18:27:00 INFO - "properties": [ 18:27:00 INFO - [ 18:27:00 INFO - "buildid", 18:27:00 INFO - "20151125143810", 18:27:00 INFO - "Change" 18:27:00 INFO - ], 18:27:00 INFO - [ 18:27:00 INFO - "builduid", 18:27:00 INFO - "eb6611f6e3f84fdabc4719336a625a11", 18:27:00 INFO - "Change" 18:27:00 INFO - ], 18:27:00 INFO - [ 18:27:00 INFO - "pgo_build", 18:27:00 INFO - "False", 18:27:00 INFO - "Change" 18:27:00 INFO - ] 18:27:00 INFO - ], 18:27:00 INFO - "revision": "9350db7159542bb6a37351d39390f64ff95faa43" 18:27:00 INFO - }, 18:27:00 INFO - { 18:27:00 INFO - "category": null, 18:27:00 INFO - "files": [ 18:27:00 INFO - { 18:27:00 INFO - "url": null, 18:27:00 INFO - "name": "https://queue.taskcluster.net/v1/task/aarv97yLQUabVroR6HF2sA/artifacts/public/build/firefox-45.0a1.en-US.win32.zip" 18:27:00 INFO - }, 18:27:00 INFO - { 18:27:00 INFO - "url": null, 18:27:00 INFO - "name": "https://queue.taskcluster.net/v1/task/aarv97yLQUabVroR6HF2sA/artifacts/public/build/test_packages.json" 18:27:00 INFO - } 18:27:00 INFO - ], 18:27:00 INFO - "repository": "", 18:27:00 INFO - "rev": "411ae8f9583dd1fdcd0d58f8294bed3a550bef05", 18:27:00 INFO - "who": "mh@glandium.org", 18:27:00 INFO - "when": 1448496360, 18:27:00 INFO - "number": 6708380, 18:27:00 INFO - "comments": "Bug 1228068 - Always set MOZ_USING_COMPILER_WRAPPER when a compiler wrapper is involved. r=gps on a CLOSED TREE\n", 18:27:00 INFO - "project": "", 18:27:00 INFO - "at": "Wed 25 Nov 2015 16:06:00", 18:27:00 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 18:27:00 INFO - "revlink": "", 18:27:00 INFO - "properties": [ 18:27:00 INFO - [ 18:27:00 INFO - "buildid", 18:27:00 INFO - "20151125150910", 18:27:00 INFO - "Change" 18:27:00 INFO - ], 18:27:00 INFO - [ 18:27:00 INFO - "builduid", 18:27:00 INFO - "c6015a9738424efd94ced5127f2f5971", 18:27:00 INFO - "Change" 18:27:00 INFO - ], 18:27:00 INFO - [ 18:27:00 INFO - "pgo_build", 18:27:00 INFO - "False", 18:27:00 INFO - "Change" 18:27:00 INFO - ] 18:27:00 INFO - ], 18:27:00 INFO - "revision": "411ae8f9583dd1fdcd0d58f8294bed3a550bef05" 18:27:00 INFO - }, 18:27:00 INFO - { 18:27:00 INFO - "category": null, 18:27:00 INFO - "files": [ 18:27:00 INFO - { 18:27:00 INFO - "url": null, 18:27:00 INFO - "name": "https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.zip" 18:27:00 INFO - }, 18:27:00 INFO - { 18:27:00 INFO - "url": null, 18:27:00 INFO - "name": "https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/test_packages.json" 18:27:00 INFO - } 18:27:00 INFO - ], 18:27:00 INFO - "repository": "", 18:27:00 INFO - "rev": "27b37512f3f39dbbcad74b913e9ac5e88451550d", 18:27:00 INFO - "who": "mh@glandium.org", 18:27:00 INFO - "when": 1448501021, 18:27:00 INFO - "number": 6708664, 18:27:00 INFO - "comments": "Backout changeset 0104f1c911ca (bug 1223530) because it breaks running on Windows XP on a CLOSED TREE\n", 18:27:00 INFO - "project": "", 18:27:00 INFO - "at": "Wed 25 Nov 2015 17:23:41", 18:27:00 INFO - "branch": "mozilla-inbound-win32-debug-unittest", 18:27:00 INFO - "revlink": "", 18:27:00 INFO - "properties": [ 18:27:00 INFO - [ 18:27:00 INFO - "buildid", 18:27:00 INFO - "20151125154013", 18:27:00 INFO - "Change" 18:27:00 INFO - ], 18:27:00 INFO - [ 18:27:00 INFO - "builduid", 18:27:00 INFO - "00cf3b29d7ef47808067e3bcbd20e732", 18:27:00 INFO - "Change" 18:27:00 INFO - ], 18:27:00 INFO - [ 18:27:00 INFO - "pgo_build", 18:27:00 INFO - "False", 18:27:00 INFO - "Change" 18:27:00 INFO - ] 18:27:00 INFO - ], 18:27:00 INFO - "revision": "27b37512f3f39dbbcad74b913e9ac5e88451550d" 18:27:00 INFO - } 18:27:00 INFO - ], 18:27:00 INFO - "revision": "27b37512f3f39dbbcad74b913e9ac5e88451550d" 18:27:00 INFO - } 18:27:00 INFO - } 18:27:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.zip. 18:27:00 INFO - Found a test packages url https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/test_packages.json. 18:27:00 INFO - Running post-action listener: _resource_record_post_action 18:27:00 INFO - ##### 18:27:00 INFO - ##### Running download-and-extract step. 18:27:00 INFO - ##### 18:27:00 INFO - Running pre-action listener: _resource_record_pre_action 18:27:00 INFO - Running main action method: download_and_extract 18:27:00 INFO - mkdir: C:\slave\test\build\tests 18:27:00 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')]} 18:27:00 INFO - https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:27:00 INFO - trying https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/test_packages.json 18:27:00 INFO - Downloading https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 18:27:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1 18:27:02 INFO - Downloaded 1221 bytes. 18:27:02 INFO - Reading from file C:\slave\test\build\test_packages.json 18:27:02 INFO - Using the following test package requirements: 18:27:02 INFO - {u'common': [u'firefox-45.0a1.en-US.win32.common.tests.zip'], 18:27:02 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 18:27:02 INFO - u'firefox-45.0a1.en-US.win32.cppunittest.tests.zip'], 18:27:02 INFO - u'jittest': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 18:27:02 INFO - u'jsshell-win32.zip'], 18:27:02 INFO - u'mochitest': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 18:27:02 INFO - u'firefox-45.0a1.en-US.win32.mochitest.tests.zip'], 18:27:02 INFO - u'mozbase': [u'firefox-45.0a1.en-US.win32.common.tests.zip'], 18:27:02 INFO - u'reftest': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 18:27:02 INFO - u'firefox-45.0a1.en-US.win32.reftest.tests.zip'], 18:27:02 INFO - u'talos': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 18:27:02 INFO - u'firefox-45.0a1.en-US.win32.talos.tests.zip'], 18:27:02 INFO - u'web-platform': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 18:27:02 INFO - u'firefox-45.0a1.en-US.win32.web-platform.tests.zip'], 18:27:02 INFO - u'webapprt': [u'firefox-45.0a1.en-US.win32.common.tests.zip'], 18:27:02 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.win32.common.tests.zip', 18:27:02 INFO - u'firefox-45.0a1.en-US.win32.xpcshell.tests.zip']} 18:27:02 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 18:27:02 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')]} 18:27:02 INFO - https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 18:27:03 INFO - trying https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.common.tests.zip 18:27:03 INFO - Downloading https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/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 18:27:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/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 18:27:04 INFO - Downloaded 19452173 bytes. 18:27:04 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 18:27:04 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/* 18:27:04 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 18:27:06 INFO - caution: filename not matched: web-platform/* 18:27:06 INFO - Return code: 11 18:27:06 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')]} 18:27:06 INFO - https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.web-platform.tests.zip matches https://queue.taskcluster.net 18:27:06 INFO - trying https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.web-platform.tests.zip 18:27:06 INFO - Downloading https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/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 18:27:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/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 18:27:08 INFO - Downloaded 30987555 bytes. 18:27:08 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 18:27:08 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/* 18:27:08 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 18:27:46 INFO - caution: filename not matched: bin/* 18:27:46 INFO - caution: filename not matched: config/* 18:27:46 INFO - caution: filename not matched: mozbase/* 18:27:46 INFO - caution: filename not matched: marionette/* 18:27:46 INFO - Return code: 11 18:27: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')]} 18:27:46 INFO - https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.zip matches https://queue.taskcluster.net 18:27:46 INFO - trying https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.zip 18:27:46 INFO - Downloading https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.zip to C:\slave\test\build\firefox-45.0a1.en-US.win32.zip 18:27:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/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 18:28:16 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.zip: The read operation timed out 18:28:16 INFO - retry: attempt #1 caught exception: The read operation timed out 18:28:16 INFO - retry: Failed, sleeping 30 seconds before retrying 18:28:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win32.zip'}, attempt #2 18:29:16 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.zip: The read operation timed out 18:29:16 INFO - retry: attempt #2 caught exception: The read operation timed out 18:29:16 INFO - retry: Failed, sleeping 60 seconds before retrying 18:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win32.zip'}, attempt #3 18:30:47 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.zip: The read operation timed out 18:30:47 INFO - retry: attempt #3 caught exception: The read operation timed out 18:30:47 INFO - Can't download from https://queue.taskcluster.net/v1/task/LsF2T1wGTaWFw77gNrxC5w/artifacts/public/build/firefox-45.0a1.en-US.win32.zip to C:\slave\test\build\firefox-45.0a1.en-US.win32.zip! 18:30:47 INFO - Caught exception: The read operation timed out 18:30:47 INFO - Caught exception: The read operation timed out 18:30:47 INFO - Caught exception: The read operation timed out 18:30:47 FATAL - Failed to download from all available URLs, aborting 18:30:47 FATAL - Running post_fatal callback... 18:30:47 FATAL - Exiting 3 18:30:47 INFO - Running post-action listener: _resource_record_post_action 18:30:47 INFO - Running post-action listener: set_extra_try_arguments 18:30:47 INFO - Running post-run listener: _resource_record_post_run 18:30:47 INFO - Running post-run listener: _upload_blobber_files 18:30:47 INFO - Blob upload gear active. 18:30:47 WARNING - Blob upload directory does not exist! program finished with exit code 3 elapsedTime=412.534000 ========= master_lag: 45.95 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' exception (results: 4, elapsed: 7 mins, 38 secs) (at 2015-11-25 18:31:32.781306) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2015-11-25 18:31:32.781907) ========= 'cmd' '/C' 'for' '%f' 'in' '(*)' 'do' '@type' '%f' in dir C:\slave\test\properties (timeout 1200 secs) watching logfiles {} argv: ['cmd', '/C', 'for', '%f', 'in', '(*)', 'do', '@type', '%f'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-098 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-098 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\properties 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-098 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.34 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2015-11-25 18:31:33.217953) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 18:31:33.218243) ========= 'rm' '-f' 'oauth.txt' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-098 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-098 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-098 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 18:31:33.391408) ========= ========= Started reboot slave lost (results: 0, elapsed: 16 secs) (at 2015-11-25 18:31:33.391676) ========= ========= Finished reboot slave lost (results: 0, elapsed: 16 secs) (at 2015-11-25 18:31:50.371977) ========= ========= Total master_lag: 46.53 =========