builder: fx-team_win8_64_test-chromez-e10s slave: t-w864-ix-184 starttime: 1446172993.51 results: success (0) buildid: 20151029171013 builduid: 6d708002e1284b3e86de0a9f0d4d2196 revision: 5cdf66dfef92364072336ce276f9f2c70d421718 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-29 19:43:13.511869) ========= master: http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-29 19:43:13.519750) ========= ========= Started set props: basedir (results: 0, elapsed: 21 secs) (at 2015-10-29 19:43:13.520284) ========= 'cd' in dir C:\\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['cd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-184\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-184 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-184 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-184\AppData\Local LOGONSERVER=\\T-W864-IX-184 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\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 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=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~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-184 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-184 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-184 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test program finished with exit code 0 elapsedTime=0.759000 basedir: 'C:\\slave\\test' ========= Finished set props: basedir (results: 0, elapsed: 21 secs) (at 2015-10-29 19:43:34.667724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 37 secs) (at 2015-10-29 19:43:34.668009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 37 secs) (at 2015-10-29 19:44:12.285858) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-10-29 19:44:12.286165) ========= '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.T-W864-IX-184\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-184 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-184 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-184\AppData\Local LOGONSERVER=\\T-W864-IX-184 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\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 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=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~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-184 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-184 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-184 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.202000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-10-29 19:44:13.624671) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-29 19:44:13.625126) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-29 19:44:13.625629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2015-10-29 19:44:13.625974) ========= '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.T-W864-IX-184\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-184 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-184 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-184\AppData\Local LOGONSERVER=\\T-W864-IX-184 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\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 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=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~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-184 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-184 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-184 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --19:44:17-- 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% 30.33 MB/s 19:44:17 (30.33 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.530000 ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2015-10-29 19:44:26.802060) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-10-29 19:44:26.802438) ========= '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.T-W864-IX-184\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-184 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-184 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-184\AppData\Local LOGONSERVER=\\T-W864-IX-184 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\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 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=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~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-184 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-184 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-184 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.306000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-10-29 19:44:30.601892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2015-10-29 19:44:30.602222) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev 5cdf66dfef92364072336ce276f9f2c70d421718 --destination scripts --debug' in dir C:\\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5cdf66dfef92364072336ce276f9f2c70d421718 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-184\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-184 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-184 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-184\AppData\Local LOGONSERVER=\\T-W864-IX-184 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\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 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=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~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-184 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-184 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-184 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2015-10-29 19:44:31,634 truncating revision to first 12 chars 2015-10-29 19:44:31,634 Setting DEBUG logging. 2015-10-29 19:44:31,634 attempt 1/10 2015-10-29 19:44:31,634 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5cdf66dfef92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-29 19:44:31,989 unpacking tar archive at: fx-team-5cdf66dfef92/testing/mozharness/ program finished with exit code 0 elapsedTime=0.896000 ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2015-10-29 19:44:36.611216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 12 secs) (at 2015-10-29 19:44:36.611515) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 12 secs) (at 2015-10-29 19:44:49.258556) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-29 19:44:49.258807) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-29 19:44:49.259181) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 14 mins, 20 secs) (at 2015-10-29 19:44:49.259473) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'chromez-e10s' '--add-option' '--webServer,localhost' '--branch-name' 'Fx-Team-Non-PGO' '--system-bits' '64' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Fx-Team-Non-PGO' in dir C:\\slave\test\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'chromez-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-184\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-184 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-184 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-184\AppData\Local LOGONSERVER=\\T-W864-IX-184 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\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 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=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~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-184 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-184 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-184 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 19:44:49 INFO - MultiFileLogger online at 20151029 19:44:49 in C:\slave\test 19:44:49 INFO - Run as scripts/scripts/talos_script.py --suite chromez-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 19:44:49 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 19:44:49 INFO - {'append_to_log': False, 19:44:49 INFO - 'base_work_dir': 'C:\\slave\\test', 19:44:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:44:49 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 19:44:49 INFO - 'branch': 'Fx-Team-Non-PGO', 19:44:49 INFO - 'buildbot_json_path': 'buildprops.json', 19:44:49 INFO - 'config_files': ('talos/windows_config.py',), 19:44:49 INFO - 'default_actions': ('clobber', 19:44:49 INFO - 'read-buildbot-config', 19:44:49 INFO - 'download-and-extract', 19:44:49 INFO - 'populate-webroot', 19:44:49 INFO - 'create-virtualenv', 19:44:49 INFO - 'install', 19:44:49 INFO - 'run-tests'), 19:44:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:44:49 INFO - 'download_minidump_stackwalk': True, 19:44:49 INFO - 'download_symbols': 'ondemand', 19:44:49 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 19:44:49 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 19:44:49 INFO - 'hg': 'c:/mozilla-build/hg/hg', 19:44:49 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 19:44:49 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 19:44:49 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 19:44:49 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 19:44:49 INFO - 'C:/mozilla-build/tooltool.py'), 19:44:49 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 19:44:49 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 19:44:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:44:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:44:49 INFO - 'installer_path': 'installer.exe', 19:44:49 INFO - 'log_level': 'info', 19:44:49 INFO - 'log_name': 'talos', 19:44:49 INFO - 'log_to_console': True, 19:44:49 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 19:44:49 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 19:44:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 19:44:49 INFO - 'opt_config_files': (), 19:44:49 INFO - 'pip_index': False, 19:44:49 INFO - 'sps_profile': False, 19:44:49 INFO - 'sps_profile_interval': 0, 19:44:49 INFO - 'suite': 'chromez-e10s', 19:44:49 INFO - 'system_bits': '64', 19:44:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:44:49 INFO - 'title': 'T-W864-IX-184', 19:44:49 INFO - 'use_talos_json': True, 19:44:49 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 19:44:49 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 19:44:49 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 19:44:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:44:49 INFO - 'work_dir': 'build'} 19:44:49 INFO - ##### 19:44:49 INFO - ##### Running clobber step. 19:44:49 INFO - ##### 19:44:49 INFO - Running pre-action listener: _resource_record_pre_action 19:44:49 INFO - Running main action method: clobber 19:44:49 INFO - rmtree: C:\slave\test\build 19:44:50 INFO - Using _rmtree_windows ... 19:44:50 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 19:45:43 INFO - Running post-action listener: _resource_record_post_action 19:45:43 INFO - ##### 19:45:43 INFO - ##### Running read-buildbot-config step. 19:45:43 INFO - ##### 19:45:43 INFO - Running pre-action listener: _resource_record_pre_action 19:45:43 INFO - Running main action method: read_buildbot_config 19:45:43 INFO - Using buildbot properties: 19:45:43 INFO - { 19:45:43 INFO - "properties": { 19:45:43 INFO - "buildnumber": 271, 19:45:43 INFO - "product": "firefox", 19:45:43 INFO - "script_repo_revision": "production", 19:45:43 INFO - "builddir": "fx-team_win8_64_test-chromez-e10s", 19:45:43 INFO - "repository": "", 19:45:43 INFO - "buildername": "Windows 8 64-bit fx-team talos chromez-e10s", 19:45:43 INFO - "buildid": "20151029171013", 19:45:43 INFO - "slavename": "t-w864-ix-184", 19:45:43 INFO - "pgo_build": "False", 19:45:43 INFO - "basedir": "C:\\slave\\test", 19:45:43 INFO - "project": "", 19:45:43 INFO - "platform": "win8_64", 19:45:43 INFO - "master": "http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/", 19:45:43 INFO - "slavebuilddir": "test", 19:45:43 INFO - "scheduler": "tests-fx-team-win64-talos", 19:45:43 INFO - "branch": "fx-team", 19:45:43 INFO - "repo_path": "integration/fx-team", 19:45:43 INFO - "stage_platform": "win64", 19:45:43 INFO - "builduid": "6d708002e1284b3e86de0a9f0d4d2196", 19:45:43 INFO - "revision": "5cdf66dfef92364072336ce276f9f2c70d421718" 19:45:43 INFO - }, 19:45:43 INFO - "sourcestamp": { 19:45:43 INFO - "repository": "", 19:45:43 INFO - "hasPatch": false, 19:45:43 INFO - "project": "", 19:45:43 INFO - "branch": "fx-team-win64-talos", 19:45:43 INFO - "changes": [ 19:45:43 INFO - { 19:45:43 INFO - "category": null, 19:45:43 INFO - "files": [ 19:45:43 INFO - { 19:45:43 INFO - "url": null, 19:45:43 INFO - "name": "https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.zip" 19:45:43 INFO - } 19:45:43 INFO - ], 19:45:43 INFO - "repository": "", 19:45:43 INFO - "rev": "5cdf66dfef92364072336ce276f9f2c70d421718", 19:45:43 INFO - "who": "dtownsend@mozilla.com", 19:45:43 INFO - "when": 1446170084, 19:45:43 INFO - "number": 6597354, 19:45:43 INFO - "comments": "Bug 1129662: sdk/page-worker should use a remote page. r=krizsa\n\nThis makes page-worker load its pages in the remote process. It does so by\ncreating a single frame in the hidden window used to ensure we have a remote\nprocess when necessary and then a module in the remote process is used to\ncreate windowless browsers to load the pages.\n\nThis does break one API, getActiveView, but I don't think we should be\nmaintaining that and it has been unstable since its inception anyway.\n\nOnce downside, the l10n module now has to use the observer service to detect\ndocuments rather than the DOM event, this might be causing more CPOW traffic\nsince that observer notification is shimmed so we may need to use the shim\nwaiver there.", 19:45:43 INFO - "project": "", 19:45:43 INFO - "at": "Thu 29 Oct 2015 18:54:44", 19:45:43 INFO - "branch": "fx-team-win64-talos", 19:45:43 INFO - "revlink": "", 19:45:43 INFO - "properties": [ 19:45:43 INFO - [ 19:45:43 INFO - "buildid", 19:45:43 INFO - "20151029171013", 19:45:43 INFO - "Change" 19:45:43 INFO - ], 19:45:43 INFO - [ 19:45:43 INFO - "builduid", 19:45:43 INFO - "6d708002e1284b3e86de0a9f0d4d2196", 19:45:43 INFO - "Change" 19:45:43 INFO - ], 19:45:43 INFO - [ 19:45:43 INFO - "pgo_build", 19:45:43 INFO - "False", 19:45:43 INFO - "Change" 19:45:43 INFO - ] 19:45:43 INFO - ], 19:45:43 INFO - "revision": "5cdf66dfef92364072336ce276f9f2c70d421718" 19:45:43 INFO - } 19:45:43 INFO - ], 19:45:43 INFO - "revision": "5cdf66dfef92364072336ce276f9f2c70d421718" 19:45:43 INFO - } 19:45:43 INFO - } 19:45:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.zip. 19:45:43 INFO - Running post-action listener: _resource_record_post_action 19:45:43 INFO - ##### 19:45:43 INFO - ##### Running download-and-extract step. 19:45:43 INFO - ##### 19:45:43 INFO - Running pre-action listener: _resource_record_pre_action 19:45:43 INFO - Running main action method: download_and_extract 19:45:43 INFO - mkdir: C:\slave\test\build\tests 19:45:43 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')]} 19:45:43 INFO - https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:45:43 INFO - trying https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/test_packages.json 19:45:43 INFO - Downloading https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 19:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1 19:45:43 INFO - Downloaded 1221 bytes. 19:45:43 INFO - Reading from file C:\slave\test\build\test_packages.json 19:45:43 INFO - Using the following test package requirements: 19:45:43 INFO - {u'common': [u'firefox-45.0a1.en-US.win64.common.tests.zip'], 19:45:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.win64.common.tests.zip', 19:45:43 INFO - u'firefox-45.0a1.en-US.win64.cppunittest.tests.zip'], 19:45:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.win64.common.tests.zip', 19:45:43 INFO - u'jsshell-win64.zip'], 19:45:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.win64.common.tests.zip', 19:45:43 INFO - u'firefox-45.0a1.en-US.win64.mochitest.tests.zip'], 19:45:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.win64.common.tests.zip'], 19:45:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.win64.common.tests.zip', 19:45:43 INFO - u'firefox-45.0a1.en-US.win64.reftest.tests.zip'], 19:45:43 INFO - u'talos': [u'firefox-45.0a1.en-US.win64.common.tests.zip', 19:45:43 INFO - u'firefox-45.0a1.en-US.win64.talos.tests.zip'], 19:45:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.win64.common.tests.zip', 19:45:43 INFO - u'firefox-45.0a1.en-US.win64.web-platform.tests.zip'], 19:45:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.win64.common.tests.zip'], 19:45:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.win64.common.tests.zip', 19:45:43 INFO - u'firefox-45.0a1.en-US.win64.xpcshell.tests.zip']} 19:45:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.win64.common.tests.zip'] for test suite category: common 19:45:43 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')]} 19:45:43 INFO - https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 19:45:44 INFO - trying https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.common.tests.zip 19:45:44 INFO - Downloading https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.common.tests.zip to C:\slave\test\build\firefox-45.0a1.en-US.win64.common.tests.zip 19:45:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.common.tests.zip'}, attempt #1 ProcessManager NOT managing child processes 19:45:45 INFO - Downloaded 18101037 bytes. 19:45:45 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.common.tests.zip'] in C:\slave\test\build\tests 19:45:45 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-45.0a1.en-US.win64.common.tests.zip 19:45:45 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 19:46:10 INFO - Return code: 0 19:46:10 INFO - Downloading packages: [u'firefox-45.0a1.en-US.win64.common.tests.zip', u'firefox-45.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 19:46:10 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')]} 19:46:10 INFO - https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 19:46:10 INFO - trying https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.common.tests.zip 19:46:10 INFO - Downloading https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.common.tests.zip to C:\slave\test\build\firefox-45.0a1.en-US.win64.common.tests.zip 19:46:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.common.tests.zip'}, attempt #1 ProcessManager NOT managing child processes 19:46:11 INFO - Downloaded 18101037 bytes. 19:46:11 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.common.tests.zip'] in C:\slave\test\build\tests 19:46:11 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-45.0a1.en-US.win64.common.tests.zip 19:46:11 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 19:46:32 INFO - Return code: 0 19:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:32 INFO - https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net 19:46:32 INFO - trying https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.talos.tests.zip 19:46:32 INFO - Downloading https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.talos.tests.zip to C:\slave\test\build\firefox-45.0a1.en-US.win64.talos.tests.zip 19:46:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.talos.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.talos.tests.zip'}, attempt #1 ProcessManager NOT managing child processes 19:46:35 INFO - Downloaded 11131307 bytes. 19:46:35 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.talos.tests.zip'] in C:\slave\test\build\tests 19:46:35 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-45.0a1.en-US.win64.talos.tests.zip 19:46:35 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.talos.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 19:46:36 INFO - Return code: 0 19:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:36 INFO - https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.zip matches https://queue.taskcluster.net 19:46:36 INFO - trying https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.zip 19:46:36 INFO - Downloading https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.zip to C:\slave\test\build\firefox-45.0a1.en-US.win64.zip 19:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.zip'}, attempt #1 19:46:37 INFO - Downloaded 54829884 bytes. 19:46:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.zip 19:46:37 INFO - mkdir: C:\slave\test\properties 19:46:37 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 19:46:37 INFO - Writing to file C:\slave\test\properties\build_url 19:46:37 INFO - Contents: 19:46:37 INFO - build_url:https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.zip 19:46:37 INFO - Running post-action listener: _resource_record_post_action 19:46:37 INFO - Running post-action listener: set_extra_try_arguments 19:46:37 INFO - ##### 19:46:37 INFO - ##### Running populate-webroot step. 19:46:37 INFO - ##### 19:46:37 INFO - Running pre-action listener: _resource_record_pre_action 19:46:37 INFO - Running main action method: populate_webroot 19:46:37 INFO - Guessing talos json url... 19:46:37 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')]} 19:46:37 INFO - https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.txt matches https://queue.taskcluster.net 19:46:38 INFO - trying https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.txt 19:46:38 INFO - Downloading https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.txt to C:\slave\test\build\firefox-45.0a1.en-US.win64.txt 19:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.txt', 'file_name': 'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.txt'}, attempt #1 19:46:38 INFO - Downloaded 103 bytes. 19:46:38 INFO - Reading from file C:\slave\test\build\firefox-45.0a1.en-US.win64.txt 19:46:38 INFO - Contents: 19:46:38 INFO - 20151029171013 19:46:38 INFO - https://hg.mozilla.org/integration/fx-team/rev/5cdf66dfef92364072336ce276f9f2c70d421718 19:46:38 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')]} 19:46:38 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/5cdf66dfef/testing/talos/talos.json 19:46:38 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/5cdf66dfef/testing/talos/talos.json to C:\slave\test\build\talos.json 19:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/5cdf66dfef/testing/talos/talos.json', 'file_name': 'C:\\slave\\test\\build\\talos.json'}, attempt #1 19:46:39 INFO - Downloaded 4264 bytes. 19:46:39 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 19:46:39 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 19:46:39 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 19:46:39 INFO - u'../fennec_ids.txt'], 19:46:39 INFO - u'tests': [u'tcheck2']}, 19:46:39 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 19:46:39 INFO - u'--tppagecycles', 19:46:39 INFO - u'7'], 19:46:39 INFO - u'tests': [u'tsvgm']}}, 19:46:39 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 19:46:39 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 19:46:39 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 19:46:39 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 19:46:39 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 19:46:39 INFO - u'tests': [u'dromaeo_css', 19:46:39 INFO - u'kraken', 19:46:39 INFO - u'v8_7']}, 19:46:39 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:39 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 19:46:39 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:39 INFO - u'talos_options': [u'--e10s'], 19:46:39 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 19:46:39 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:39 INFO - u'tests': [u'damp', u'tps']}, 19:46:39 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:39 INFO - u'talos_options': [u'--e10s'], 19:46:39 INFO - u'tests': [u'damp', u'tps']}, 19:46:39 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 19:46:39 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 19:46:39 INFO - u'other': {u'tests': [u'a11yr', 19:46:39 INFO - u'ts_paint', 19:46:39 INFO - u'tpaint', 19:46:39 INFO - u'sessionrestore', 19:46:39 INFO - u'sessionrestore_no_auto_restore']}, 19:46:39 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 19:46:39 INFO - u'tests': [u'a11yr', 19:46:39 INFO - u'ts_paint', 19:46:39 INFO - u'tpaint', 19:46:39 INFO - u'sessionrestore', 19:46:39 INFO - u'sessionrestore_no_auto_restore']}, 19:46:39 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 19:46:39 INFO - u'tests': [u'a11yr', 19:46:39 INFO - u'ts_paint', 19:46:39 INFO - u'tpaint', 19:46:39 INFO - u'sessionrestore', 19:46:39 INFO - u'sessionrestore_no_auto_restore']}, 19:46:39 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 19:46:39 INFO - u'tests': [u'a11yr', 19:46:39 INFO - u'ts_paint', 19:46:39 INFO - u'tpaint', 19:46:39 INFO - u'sessionrestore', 19:46:39 INFO - u'sessionrestore_no_auto_restore']}, 19:46:39 INFO - u'other_l64': {u'tests': [u'a11yr', 19:46:39 INFO - u'ts_paint', 19:46:39 INFO - u'tpaint', 19:46:39 INFO - u'sessionrestore', 19:46:39 INFO - u'sessionrestore_no_auto_restore']}, 19:46:39 INFO - u'other_nol64': {u'tests': [u'a11yr', 19:46:39 INFO - u'ts_paint', 19:46:39 INFO - u'tpaint', 19:46:39 INFO - u'sessionrestore', 19:46:39 INFO - u'sessionrestore_no_auto_restore']}, 19:46:39 INFO - u'svgr': {u'tests': [u'tsvgx', 19:46:39 INFO - u'tsvgr_opacity', 19:46:39 INFO - u'tart', 19:46:39 INFO - u'tscrollx', 19:46:39 INFO - u'cart']}, 19:46:39 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 19:46:39 INFO - u'tests': [u'tsvgx', 19:46:39 INFO - u'tsvgr_opacity', 19:46:39 INFO - u'tart', 19:46:39 INFO - u'tscrollx', 19:46:39 INFO - u'cart']}, 19:46:39 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:39 INFO - u'tests': [u'tp5o']}, 19:46:39 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:39 INFO - u'talos_options': [u'--e10s'], 19:46:39 INFO - u'tests': [u'tp5o']}, 19:46:39 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:39 INFO - u'talos_options': [u'--xperf_path', 19:46:39 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:39 INFO - u'tests': [u'tp5n']}, 19:46:39 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:39 INFO - u'talos_options': [u'--e10s', 19:46:39 INFO - u'--xperf_path', 19:46:39 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 19:46:39 INFO - u'C:/slave/talos-data/talos/xperf.config'], 19:46:39 INFO - u'tests': [u'tp5n']}}, 19:46:39 INFO - u'talos.zip': {u'path': u'', 19:46:39 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:46:39 INFO - Running post-action listener: _resource_record_post_action 19:46:39 INFO - ##### 19:46:39 INFO - ##### Running create-virtualenv step. 19:46:39 INFO - ##### 19:46:39 INFO - Running pre-action listener: _resource_record_pre_action 19:46:39 INFO - Running main action method: create_virtualenv 19:46:39 INFO - Creating virtualenv C:\slave\test\build/venv 19:46:39 INFO - mkdir: C:\slave\test\build\venv\Scripts 19:46:39 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 19:46:39 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 19:46:39 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 19:46:39 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 19:46:47 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 19:46:51 INFO - Installing distribute......................................................................................................................................................................................done. 19:46:52 INFO - Return code: 0 19:46:52 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 19:46:52 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')]} 19:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:52 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')]} 19:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:52 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02452B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024ABEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02567548>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00468B48>, '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 0x0048A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02879660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-184', 'USERDOMAIN': 'T-W864-IX-184', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-184', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\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', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 19:46:53 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', 'pip>=1.5'] in C:\slave\test\build 19:46:53 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 pip>=1.5 19:46:53 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:46:53 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 19:46:53 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:46:53 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:46:53 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:46:53 INFO - 'COMPUTERNAME': 'T-W864-IX-184', 19:46:53 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:46:53 INFO - 'DCLOCATION': 'SCL3', 19:46:53 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:46:53 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:46:53 INFO - 'HOMEDRIVE': 'C:', 19:46:53 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 19:46:53 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:46:53 INFO - 'KTS_VERSION': '1.19c', 19:46:53 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 19:46:53 INFO - 'LOGONSERVER': '\\\\T-W864-IX-184', 19:46:53 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:46:53 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:53 INFO - 'MOZ_NO_REMOTE': '1', 19:46:53 INFO - 'NO_EM_RESTART': '1', 19:46:53 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:46:53 INFO - 'OS': 'Windows_NT', 19:46:53 INFO - 'OURDRIVE': 'C:', 19:46:53 INFO - 'PATH': 'C:\\Program Files (x86)\\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', 19:46:53 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:46:53 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:46:53 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:46:53 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:46:53 INFO - 'PROCESSOR_LEVEL': '6', 19:46:53 INFO - 'PROCESSOR_REVISION': '1e05', 19:46:53 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:46:53 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:46:53 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:46:53 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:46:53 INFO - 'PROMPT': '$P$G', 19:46:53 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:46:53 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:46:53 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:46:53 INFO - 'PWD': 'C:\\slave\\test', 19:46:53 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:46:53 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:46:53 INFO - 'SYSTEMDRIVE': 'C:', 19:46:53 INFO - 'SYSTEMROOT': 'C:\\windows', 19:46:53 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:46:53 INFO - 'TEST1': 'testie', 19:46:53 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:46:53 INFO - 'USERDOMAIN': 'T-W864-IX-184', 19:46:53 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 19:46:53 INFO - 'USERNAME': 'cltbld', 19:46:53 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 19:46:53 INFO - 'WINDIR': 'C:\\windows', 19:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:46:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 19:46:53 INFO - Downloading/unpacking pip>=1.5 19:46:53 INFO - Creating supposed download cache at C:\slave\test\build/venv\cache 19:46:58 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz 19:46:58 INFO - Running setup.py egg_info for package pip 19:46:58 INFO - warning: no files found matching 'pip\cacert.pem' 19:46:58 INFO - warning: no files found matching '*.html' under directory 'docs' 19:46:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 19:46:58 INFO - no previously-included directories found matching 'docs\_build\_sources' 19:46:58 INFO - Installing collected packages: pip 19:46:58 INFO - Found existing installation: pip 0.8.2 19:46:58 INFO - Uninstalling pip: 19:46:58 INFO - Successfully uninstalled pip 19:46:58 INFO - Running setup.py install for pip 19:46:58 INFO - warning: no files found matching 'pip\cacert.pem' 19:46:58 INFO - warning: no files found matching '*.html' under directory 'docs' 19:46:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 19:46:58 INFO - no previously-included directories found matching 'docs\_build\_sources' 19:46:58 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 19:46:58 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 19:46:58 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 19:46:58 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 19:46:58 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 19:46:58 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 19:46:58 INFO - Successfully installed pip 19:46:58 INFO - Cleaning up... 19:46:58 INFO - Return code: 0 19:46:58 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build/venv 19:46:58 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')]} 19:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:58 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')]} 19:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:58 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 0x02452B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024ABEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02567548>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00468B48>, '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 0x0048A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02879660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-184', 'USERDOMAIN': 'T-W864-IX-184', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-184', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\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', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 19:46:58 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 19:46:58 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 19:46:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:46:58 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 19:46:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:46:58 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:46:58 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:46:58 INFO - 'COMPUTERNAME': 'T-W864-IX-184', 19:46:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:46:58 INFO - 'DCLOCATION': 'SCL3', 19:46:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:46:58 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:46:58 INFO - 'HOMEDRIVE': 'C:', 19:46:58 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 19:46:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:46:58 INFO - 'KTS_VERSION': '1.19c', 19:46:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 19:46:58 INFO - 'LOGONSERVER': '\\\\T-W864-IX-184', 19:46:58 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:46:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:58 INFO - 'MOZ_NO_REMOTE': '1', 19:46:58 INFO - 'NO_EM_RESTART': '1', 19:46:58 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:46:58 INFO - 'OS': 'Windows_NT', 19:46:58 INFO - 'OURDRIVE': 'C:', 19:46:58 INFO - 'PATH': 'C:\\Program Files (x86)\\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', 19:46:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:46:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:46:58 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:46:58 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:46:58 INFO - 'PROCESSOR_LEVEL': '6', 19:46:58 INFO - 'PROCESSOR_REVISION': '1e05', 19:46:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:46:58 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:46:58 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:46:58 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:46:58 INFO - 'PROMPT': '$P$G', 19:46:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:46:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:46:58 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:46:58 INFO - 'PWD': 'C:\\slave\\test', 19:46:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:46:58 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:46:58 INFO - 'SYSTEMDRIVE': 'C:', 19:46:58 INFO - 'SYSTEMROOT': 'C:\\windows', 19:46:58 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:46:58 INFO - 'TEST1': 'testie', 19:46:58 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:46:58 INFO - 'USERDOMAIN': 'T-W864-IX-184', 19:46:58 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 19:46:58 INFO - 'USERNAME': 'cltbld', 19:46:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 19:46:58 INFO - 'WINDIR': 'C:\\windows', 19:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:00 INFO - Downloading/unpacking psutil>=0.7.1 19:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:00 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-cp27-none-win32.whl 19:47:00 INFO - Installing collected packages: psutil 19:47:00 INFO - Successfully installed psutil 19:47:00 INFO - Cleaning up... 19:47:01 INFO - Return code: 0 19:47:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test\build/venv 19:47:01 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')]} 19:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:01 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')]} 19:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:01 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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02452B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024ABEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02567548>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00468B48>, '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 0x0048A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02879660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-184', 'USERDOMAIN': 'T-W864-IX-184', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-184', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\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', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 19:47:01 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', 'mozsystemmonitor==0.0.0'] in C:\slave\test\build 19:47:01 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 mozsystemmonitor==0.0.0 19:47:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:47:01 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 19:47:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:47:01 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:47:01 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:47:01 INFO - 'COMPUTERNAME': 'T-W864-IX-184', 19:47:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:47:01 INFO - 'DCLOCATION': 'SCL3', 19:47:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:47:01 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:47:01 INFO - 'HOMEDRIVE': 'C:', 19:47:01 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 19:47:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:47:01 INFO - 'KTS_VERSION': '1.19c', 19:47:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 19:47:01 INFO - 'LOGONSERVER': '\\\\T-W864-IX-184', 19:47:01 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:47:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:01 INFO - 'MOZ_NO_REMOTE': '1', 19:47:01 INFO - 'NO_EM_RESTART': '1', 19:47:01 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:47:01 INFO - 'OS': 'Windows_NT', 19:47:01 INFO - 'OURDRIVE': 'C:', 19:47:01 INFO - 'PATH': 'C:\\Program Files (x86)\\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', 19:47:01 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:47:01 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:47:01 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:47:01 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:47:01 INFO - 'PROCESSOR_LEVEL': '6', 19:47:01 INFO - 'PROCESSOR_REVISION': '1e05', 19:47:01 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:47:01 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:47:01 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:47:01 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:47:01 INFO - 'PROMPT': '$P$G', 19:47:01 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:47:01 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:47:01 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:47:01 INFO - 'PWD': 'C:\\slave\\test', 19:47:01 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:47:01 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:47:01 INFO - 'SYSTEMDRIVE': 'C:', 19:47:01 INFO - 'SYSTEMROOT': 'C:\\windows', 19:47:01 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:01 INFO - 'TEST1': 'testie', 19:47:01 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:01 INFO - 'USERDOMAIN': 'T-W864-IX-184', 19:47:01 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 19:47:01 INFO - 'USERNAME': 'cltbld', 19:47:01 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 19:47:01 INFO - 'WINDIR': 'C:\\windows', 19:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:47:02 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmozsystemmonitor-0.0.tar.gz 19:47:02 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 19:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.0.0) 19:47:02 INFO - Installing collected packages: mozsystemmonitor 19:47:02 INFO - Running setup.py install for mozsystemmonitor 19:47:02 INFO - Successfully installed mozsystemmonitor 19:47:02 INFO - Cleaning up... 19:47:02 INFO - Return code: 0 19:47:02 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 19:47: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')]} 19:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47: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')]} 19:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:02 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', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02452B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024ABEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02567548>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00468B48>, '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 0x0048A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02879660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-184', 'USERDOMAIN': 'T-W864-IX-184', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-184', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\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', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 19:47:02 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', 'blobuploader==1.2.4'] in C:\slave\test\build 19:47:02 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 blobuploader==1.2.4 19:47:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:47:02 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 19:47:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:47:02 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:47:02 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:47:02 INFO - 'COMPUTERNAME': 'T-W864-IX-184', 19:47:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:47:02 INFO - 'DCLOCATION': 'SCL3', 19:47:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:47:02 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:47:02 INFO - 'HOMEDRIVE': 'C:', 19:47:02 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 19:47:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:47:02 INFO - 'KTS_VERSION': '1.19c', 19:47:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 19:47:02 INFO - 'LOGONSERVER': '\\\\T-W864-IX-184', 19:47:02 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:47:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:02 INFO - 'MOZ_NO_REMOTE': '1', 19:47:02 INFO - 'NO_EM_RESTART': '1', 19:47:02 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:47:02 INFO - 'OS': 'Windows_NT', 19:47:02 INFO - 'OURDRIVE': 'C:', 19:47:02 INFO - 'PATH': 'C:\\Program Files (x86)\\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', 19:47:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:47:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:47:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:47:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:47:02 INFO - 'PROCESSOR_LEVEL': '6', 19:47:02 INFO - 'PROCESSOR_REVISION': '1e05', 19:47:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:47:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:47:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:47:02 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:47:02 INFO - 'PROMPT': '$P$G', 19:47:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:47:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:47:02 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:47:02 INFO - 'PWD': 'C:\\slave\\test', 19:47:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:47:02 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:47:02 INFO - 'SYSTEMDRIVE': 'C:', 19:47:02 INFO - 'SYSTEMROOT': 'C:\\windows', 19:47:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:02 INFO - 'TEST1': 'testie', 19:47:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:02 INFO - 'USERDOMAIN': 'T-W864-IX-184', 19:47:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 19:47:02 INFO - 'USERNAME': 'cltbld', 19:47:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 19:47:02 INFO - 'WINDIR': 'C:\\windows', 19:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:03 INFO - Downloading/unpacking blobuploader==1.2.4 19:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:04 INFO - Downloading blobuploader-1.2.4.tar.gz 19:47:04 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblobuploader-1.2.4.tar.gz 19:47:04 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 19:47:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:04 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2frequests-1.2.3.tar.gz 19:47:04 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 19:47:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:04 INFO - Downloading docopt-0.6.1.tar.gz 19:47:04 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fdocopt-0.6.1.tar.gz 19:47:04 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 19:47:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:47:04 INFO - Running setup.py install for blobuploader 19:47:04 INFO - Running setup.py install for requests 19:47:05 INFO - Running setup.py install for docopt 19:47:05 INFO - Successfully installed blobuploader requests docopt 19:47:05 INFO - Cleaning up... 19:47:07 INFO - Return code: 0 19:47:07 INFO - Installing None into virtualenv C:\slave\test\build/venv 19:47: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')]} 19:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47: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')]} 19:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:07 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02452B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024ABEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02567548>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00468B48>, '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 0x0048A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02879660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-184', 'USERDOMAIN': 'T-W864-IX-184', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-184', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\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', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 19:47:07 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 19:47:07 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:47:07 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:47:07 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 19:47:07 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:47:07 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:47:07 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:47:07 INFO - 'COMPUTERNAME': 'T-W864-IX-184', 19:47:07 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:47:07 INFO - 'DCLOCATION': 'SCL3', 19:47:07 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:47:07 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:47:07 INFO - 'HOMEDRIVE': 'C:', 19:47:07 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 19:47:07 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:47:07 INFO - 'KTS_VERSION': '1.19c', 19:47:07 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 19:47:07 INFO - 'LOGONSERVER': '\\\\T-W864-IX-184', 19:47:07 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:47:07 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:07 INFO - 'MOZ_NO_REMOTE': '1', 19:47:07 INFO - 'NO_EM_RESTART': '1', 19:47:07 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:47:07 INFO - 'OS': 'Windows_NT', 19:47:07 INFO - 'OURDRIVE': 'C:', 19:47:07 INFO - 'PATH': 'C:\\Program Files (x86)\\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', 19:47:07 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:47:07 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:47:07 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:47:07 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:47:07 INFO - 'PROCESSOR_LEVEL': '6', 19:47:07 INFO - 'PROCESSOR_REVISION': '1e05', 19:47:07 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:47:07 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:47:07 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:47:07 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:47:07 INFO - 'PROMPT': '$P$G', 19:47:07 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:47:07 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:47:07 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:47:07 INFO - 'PWD': 'C:\\slave\\test', 19:47:07 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:47:07 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:47:07 INFO - 'SYSTEMDRIVE': 'C:', 19:47:07 INFO - 'SYSTEMROOT': 'C:\\windows', 19:47:07 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:07 INFO - 'TEST1': 'testie', 19:47:07 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:07 INFO - 'USERDOMAIN': 'T-W864-IX-184', 19:47:07 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 19:47:07 INFO - 'USERNAME': 'cltbld', 19:47:07 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 19:47:07 INFO - 'WINDIR': 'C:\\windows', 19:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 19:47:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-swfoab-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 19:47:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 19:47:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7s4hdj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 19:47:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 19:47:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-aezi4b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 19:47:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 19:47:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ipuipc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 19:47:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 19:47:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8ulezv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 19:47:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 19:47:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-71rscv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 19:47:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 19:47:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-d7hnsh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 19:47:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 19:47:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-88xjp9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 19:47:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 19:47:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7yymgq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 19:47:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 19:47:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-trwxor-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 19:47:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 19:47:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dmirk1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 19:47:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 19:47:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hef2tm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 19:47:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 19:47:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dgiau7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 19:47:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 19:47:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mdnsrb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 19:47:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 19:47:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gvssjo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 19:47:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 19:47:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sqv_bn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 19:47:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 19:47:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dcwney-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 19:47:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:47:09 INFO - Running setup.py install for manifestparser 19:47:09 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 19:47:09 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 19:47:09 INFO - Running setup.py install for mozcrash 19:47:10 INFO - Running setup.py install for mozdebug 19:47:10 INFO - Running setup.py install for mozdevice 19:47:10 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 19:47:10 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 19:47:10 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 19:47:10 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 19:47:11 INFO - Running setup.py install for mozfile 19:47:11 INFO - Running setup.py install for mozhttpd 19:47:11 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 19:47:11 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 19:47:12 INFO - Running setup.py install for mozinfo 19:47:12 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 19:47:12 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 19:47:12 INFO - Running setup.py install for mozInstall 19:47:12 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 19:47:12 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 19:47:12 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 19:47:12 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 19:47:12 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 19:47:12 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 19:47:12 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 19:47:12 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 19:47:12 INFO - Running setup.py install for mozleak 19:47:13 INFO - Running setup.py install for mozlog 19:47:13 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 19:47:13 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 19:47:14 INFO - Running setup.py install for moznetwork 19:47:14 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 19:47:14 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 19:47:14 INFO - Running setup.py install for mozprocess 19:47:14 INFO - Running setup.py install for mozprofile 19:47:15 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 19:47:15 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 19:47:15 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 19:47:15 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 19:47:15 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 19:47:15 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 19:47:15 INFO - Running setup.py install for mozrunner 19:47:15 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 19:47:15 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 19:47:16 INFO - Running setup.py install for mozscreenshot 19:47:16 INFO - Running setup.py install for moztest 19:47:17 INFO - Running setup.py install for mozversion 19:47:17 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 19:47:17 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 19:47:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:47:17 INFO - Cleaning up... 19:47:17 INFO - Return code: 0 19:47:17 INFO - Installing None into virtualenv C:\slave\test\build/venv 19:47:17 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')]} 19:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:17 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')]} 19:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:17 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', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02452B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024ABEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02567548>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00468B48>, '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 0x0048A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02879660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-184', 'USERDOMAIN': 'T-W864-IX-184', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-184', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\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', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 19:47:17 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 19:47:17 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:47:17 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:47:17 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 19:47:17 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:47:17 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:47:17 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:47:17 INFO - 'COMPUTERNAME': 'T-W864-IX-184', 19:47:17 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:47:17 INFO - 'DCLOCATION': 'SCL3', 19:47:17 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:47:17 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:47:17 INFO - 'HOMEDRIVE': 'C:', 19:47:17 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 19:47:17 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:47:17 INFO - 'KTS_VERSION': '1.19c', 19:47:17 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 19:47:17 INFO - 'LOGONSERVER': '\\\\T-W864-IX-184', 19:47:17 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:47:17 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:17 INFO - 'MOZ_NO_REMOTE': '1', 19:47:17 INFO - 'NO_EM_RESTART': '1', 19:47:17 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:47:17 INFO - 'OS': 'Windows_NT', 19:47:17 INFO - 'OURDRIVE': 'C:', 19:47:17 INFO - 'PATH': 'C:\\Program Files (x86)\\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', 19:47:17 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:47:17 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:47:17 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:47:17 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:47:17 INFO - 'PROCESSOR_LEVEL': '6', 19:47:17 INFO - 'PROCESSOR_REVISION': '1e05', 19:47:17 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:47:17 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:47:17 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:47:17 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:47:17 INFO - 'PROMPT': '$P$G', 19:47:17 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:47:17 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:47:17 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:47:17 INFO - 'PWD': 'C:\\slave\\test', 19:47:17 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:47:17 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:47:17 INFO - 'SYSTEMDRIVE': 'C:', 19:47:17 INFO - 'SYSTEMROOT': 'C:\\windows', 19:47:17 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:17 INFO - 'TEST1': 'testie', 19:47:17 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:17 INFO - 'USERDOMAIN': 'T-W864-IX-184', 19:47:17 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 19:47:17 INFO - 'USERNAME': 'cltbld', 19:47:17 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 19:47:17 INFO - 'WINDIR': 'C:\\windows', 19:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 19:47:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wjq6ja-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 19:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1)) 19:47:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 19:47:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gycpwr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 19:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 19:47:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 19:47:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-opvvrm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 19:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 19:47:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 19:47:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wq5_7j-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 19:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 19:47:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 19:47:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xlspv7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 19:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5)) 19:47:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 19:47:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2hckqx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 19:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6)) 19:47:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 19:47:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ym1ous-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 19:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7)) 19:47:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 19:47:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jj_8bi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 19:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test/build/tests/mozbase/mozinstall in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 8)) 19:47:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 19:47:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gjfnqg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 19:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9)) 19:47:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 19:47:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-n3pqk0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 19:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 19:47:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 19:47:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-aut0zr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11)) 19:47:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 19:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vjup7b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12)) 19:47:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 19:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nbuo7t-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13)) 19:47:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 19:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dpw72u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 19:47:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 19:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gz_ibj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15)) 19:47:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 19:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0xaf0x-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test/build/tests/mozbase/moztest in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 16)) 19:47:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 19:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-klirfq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17)) 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 19:47:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 19:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:20 INFO - Downloading blessings-1.5.1.tar.gz 19:47:20 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblessings-1.5.1.tar.gz 19:47:20 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 19:47:21 INFO - Installing collected packages: blessings 19:47:21 INFO - Running setup.py install for blessings 19:47:21 INFO - Successfully installed blessings 19:47:21 INFO - Cleaning up... 19:47:24 INFO - Return code: 0 19:47:24 INFO - Done creating virtualenv C:\slave\test\build/venv. 19:47:24 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 19:47:24 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 19:47:24 INFO - Reading from file tmpfile_stdout 19:47:24 INFO - Using _rmtree_windows ... 19:47:24 INFO - Using _rmtree_windows ... 19:47:24 INFO - Current package versions: 19:47:24 INFO - blessings == 1.5.1 19:47:24 INFO - blobuploader == 1.2.4 19:47:24 INFO - docopt == 0.6.1 19:47:24 INFO - manifestparser == 1.1 19:47:24 INFO - mozInstall == 1.12 19:47:24 INFO - mozcrash == 0.16 19:47:24 INFO - mozdebug == 0.1 19:47:24 INFO - mozdevice == 0.46 19:47:24 INFO - mozfile == 1.2 19:47:24 INFO - mozhttpd == 0.7 19:47:24 INFO - mozinfo == 0.8 19:47:24 INFO - mozleak == 0.1 19:47:24 INFO - mozlog == 3.0 19:47:24 INFO - moznetwork == 0.27 19:47:24 INFO - mozprocess == 0.22 19:47:24 INFO - mozprofile == 0.27 19:47:24 INFO - mozrunner == 6.11 19:47:24 INFO - mozscreenshot == 0.1 19:47:24 INFO - mozsystemmonitor == 0.0 19:47:24 INFO - moztest == 0.7 19:47:24 INFO - mozversion == 1.4 19:47:24 INFO - psutil == 3.1.1 19:47:24 INFO - requests == 1.2.3 19:47:24 INFO - Installing None into virtualenv C:\slave\test\build/venv 19:47:24 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')]} 19:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:24 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')]} 19:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:24 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', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02452B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024ABEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02567548>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00468B48>, '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 0x0048A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02879660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-184', 'USERDOMAIN': 'T-W864-IX-184', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-184', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\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', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 19:47:24 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\talos 19:47:24 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:47:24 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:47:24 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 19:47:24 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:47:24 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:47:24 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:47:24 INFO - 'COMPUTERNAME': 'T-W864-IX-184', 19:47:24 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:47:24 INFO - 'DCLOCATION': 'SCL3', 19:47:24 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:47:24 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:47:24 INFO - 'HOMEDRIVE': 'C:', 19:47:24 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 19:47:24 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:47:24 INFO - 'KTS_VERSION': '1.19c', 19:47:24 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 19:47:24 INFO - 'LOGONSERVER': '\\\\T-W864-IX-184', 19:47:24 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:47:24 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:24 INFO - 'MOZ_NO_REMOTE': '1', 19:47:24 INFO - 'NO_EM_RESTART': '1', 19:47:24 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:47:24 INFO - 'OS': 'Windows_NT', 19:47:24 INFO - 'OURDRIVE': 'C:', 19:47:24 INFO - 'PATH': 'C:\\Program Files (x86)\\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', 19:47:24 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:47:24 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:47:24 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:47:24 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:47:24 INFO - 'PROCESSOR_LEVEL': '6', 19:47:24 INFO - 'PROCESSOR_REVISION': '1e05', 19:47:24 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:47:24 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:47:24 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:47:24 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:47:24 INFO - 'PROMPT': '$P$G', 19:47:24 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:47:24 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:47:24 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:47:24 INFO - 'PWD': 'C:\\slave\\test', 19:47:24 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:47:24 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:47:24 INFO - 'SYSTEMDRIVE': 'C:', 19:47:24 INFO - 'SYSTEMROOT': 'C:\\windows', 19:47:24 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:24 INFO - 'TEST1': 'testie', 19:47:24 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:24 INFO - 'USERDOMAIN': 'T-W864-IX-184', 19:47:24 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 19:47:24 INFO - 'USERNAME': 'cltbld', 19:47:24 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 19:47:24 INFO - 'WINDIR': 'C:\\windows', 19:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2)) 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5)) 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6)) 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7)) 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8)) 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.0->mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 19:47:25 INFO - Cleaning up... 19:47:25 INFO - Return code: 0 19:47:25 INFO - Running post-action listener: _resource_record_post_action 19:47:25 INFO - Running post-action listener: _start_resource_monitoring 19:47:25 INFO - Starting resource monitoring. 19:47:25 INFO - ##### 19:47:25 INFO - ##### Running install step. 19:47:25 INFO - ##### 19:47:25 INFO - Running pre-action listener: _resource_record_pre_action 19:47:25 INFO - Running main action method: install 19:47:25 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 19:47:25 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 19:47:25 INFO - Reading from file tmpfile_stdout 19:47:25 INFO - Using _rmtree_windows ... 19:47:25 INFO - Using _rmtree_windows ... 19:47:25 INFO - Detecting whether we're running mozinstall >=1.0... 19:47:25 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 19:47:25 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 19:47:25 INFO - Reading from file tmpfile_stdout 19:47:25 INFO - Output received: 19:47:25 INFO - Usage: mozinstall-script.py [options] installer 19:47:25 INFO - Options: 19:47:25 INFO - -h, --help show this help message and exit 19:47:25 INFO - -d DEST, --destination=DEST 19:47:25 INFO - Directory to install application into. [default: 19:47:25 INFO - "C:\slave\test"] 19:47:25 INFO - --app=APP Application being installed. [default: firefox] 19:47:25 INFO - Using _rmtree_windows ... 19:47:25 INFO - Using _rmtree_windows ... 19:47:25 INFO - mkdir: C:\slave\test\build\application 19:47:25 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-45.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 19:47:25 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-45.0a1.en-US.win64.zip --destination C:\slave\test\build\application 19:47:27 INFO - Reading from file tmpfile_stdout 19:47:27 INFO - Output received: 19:47:27 INFO - C:\slave\test\build\application\firefox\firefox.exe 19:47:27 INFO - Using _rmtree_windows ... 19:47:27 INFO - Using _rmtree_windows ... 19:47:27 INFO - Running post-action listener: _resource_record_post_action 19:47:27 INFO - ##### 19:47:27 INFO - ##### Running run-tests step. 19:47:27 INFO - ##### 19:47:27 INFO - Running pre-action listener: _resource_record_pre_action 19:47:27 INFO - Running main action method: run_tests 19:47:27 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 19:47:27 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 19:47:27 INFO - Python 2.7.3 19:47:27 INFO - Return code: 0 19:47:27 INFO - grabbing minidump binary from tooltool 19:47:27 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')]} 19:47:27 INFO - retry: Calling run_command with args: (['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00468B48>, '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 0x0048A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02879660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 19:47:27 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build 19:47:27 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test\build\tests\config/tooltool-manifests/win32/releng.manifest -o 19:47:27 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 19:47:27 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmp3ad0xx 19:47:27 INFO - INFO - File integrity verified, renaming tmp3ad0xx to win32-minidump_stackwalk.exe 19:47:27 INFO - Return code: 0 19:47:27 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 19:47:27 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 19:47:27 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 19:47:27 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 19:47:27 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 19:47:27 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'chromez-e10s', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-184', '--webServer', 'localhost'] in C:\slave\test\build 19:47:27 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --debug --branchName Fx-Team-Non-PGO --suite chromez-e10s --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-184 --webServer localhost 19:47:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:47:27 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Roaming', 19:47:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:47:27 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:47:27 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:47:27 INFO - 'COMPUTERNAME': 'T-W864-IX-184', 19:47:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:47:27 INFO - 'DCLOCATION': 'SCL3', 19:47:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:47:27 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:47:27 INFO - 'HOMEDRIVE': 'C:', 19:47:27 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-184', 19:47:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:47:27 INFO - 'KTS_VERSION': '1.19c', 19:47:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-184\\AppData\\Local', 19:47:27 INFO - 'LOGONSERVER': '\\\\T-W864-IX-184', 19:47:27 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 19:47:27 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 19:47:27 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:47:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:27 INFO - 'MOZ_NO_REMOTE': '1', 19:47:27 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 19:47:27 INFO - 'NO_EM_RESTART': '1', 19:47:27 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:47:27 INFO - 'OS': 'Windows_NT', 19:47:27 INFO - 'OURDRIVE': 'C:', 19:47:27 INFO - 'PATH': 'C:\\Program Files (x86)\\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', 19:47:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:47:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:47:27 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:47:27 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:47:27 INFO - 'PROCESSOR_LEVEL': '6', 19:47:27 INFO - 'PROCESSOR_REVISION': '1e05', 19:47:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:47:27 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:47:27 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:47:27 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:47:27 INFO - 'PROMPT': '$P$G', 19:47:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:47:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:47:27 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:47:27 INFO - 'PWD': 'C:\\slave\\test', 19:47:27 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 19:47:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:47:27 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:47:27 INFO - 'SYSTEMDRIVE': 'C:', 19:47:27 INFO - 'SYSTEMROOT': 'C:\\windows', 19:47:27 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:27 INFO - 'TEST1': 'testie', 19:47:27 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:47:27 INFO - 'USERDOMAIN': 'T-W864-IX-184', 19:47:27 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-184', 19:47:27 INFO - 'USERNAME': 'cltbld', 19:47:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-184', 19:47:27 INFO - 'WINDIR': 'C:\\windows', 19:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:47:27 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'chromez-e10s', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-184', '--webServer', 'localhost'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 19:47:28 INFO - mozversion INFO | application_buildid: 20151029171013 19:47:28 INFO - mozversion INFO | application_changeset: 5cdf66dfef92364072336ce276f9f2c70d421718 19:47:28 INFO - mozversion INFO | application_display_name: Nightly 19:47:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:47:28 INFO - mozversion INFO | application_name: Firefox 19:47:28 INFO - mozversion INFO | application_remotingname: firefox 19:47:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:47:28 INFO - mozversion INFO | application_vendor: Mozilla 19:47:28 INFO - mozversion INFO | application_version: 45.0a1 19:47:28 INFO - mozversion INFO | platform_buildid: 20151029171013 19:47:28 INFO - mozversion INFO | platform_changeset: 5cdf66dfef92364072336ce276f9f2c70d421718 19:47:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:47:28 INFO - mozversion INFO | platform_version: 45.0a1 19:47:28 INFO - 2015-10-29 19:47:28,696 DEBUG : using testdate: 1446173248 19:47:28 INFO - 2015-10-29 19:47:28,697 DEBUG : actual date: 1446173248 19:47:28 INFO - 2015-10-29 19:47:28,796 INFO : starting webserver on 'localhost:49276' 19:47:28 INFO - 2015-10-29 19:47:28,798 INFO : Starting test suite T-W864-IX-184.e 19:47:28 INFO - 2015-10-29 19:47:28,799 INFO : Starting test tresize 19:47:28 INFO - 2015-10-29 19:47:28,799 DEBUG : operating with platform_type : w8_ 19:47:28 INFO - 2015-10-29 19:47:28,799 INFO : Initialising browser for tresize test... 19:47:28 INFO - 2015-10-29 19:47:28,977 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/getInfo.html 19:47:37 INFO - 2015-10-29 19:47:37,417 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:47:37 INFO - 2015-10-29 19:47:37,417 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:47:37 INFO - 2015-10-29 19:47:37,417 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 19:47:37 INFO - 2015-10-29 19:47:37,417 DEBUG : BROWSER_OUTPUT: __metrics 19:47:39 INFO - 2015-10-29 19:47:39,326 INFO : Browser initialized. 19:47:39 INFO - 2015-10-29 19:47:39,326 INFO : Running cycle 1/20 for tresize test... 19:47:39 INFO - 2015-10-29 19:47:39,326 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:47:51 INFO - 2015-10-29 19:47:51,555 DEBUG : BROWSER_OUTPUT: __start_report13.392966666666652__end_report 19:47:51 INFO - 2015-10-29 19:47:51,555 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173271555__endTimestamp 19:47:51 INFO - 2015-10-29 19:47:51,756 DEBUG : BROWSER_OUTPUT: [Child 1720] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:47:51 INFO - 2015-10-29 19:47:51,756 DEBUG : BROWSER_OUTPUT: [Child 1720] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:47:52 INFO - 2015-10-29 19:47:52,430 INFO : Browser exited with error code: 0 19:47:52 INFO - 2015-10-29 19:47:52,434 INFO : Running cycle 2/20 for tresize test... 19:47:52 INFO - 2015-10-29 19:47:52,434 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:48:04 INFO - 2015-10-29 19:48:04,082 DEBUG : BROWSER_OUTPUT: __start_report12.796166666666673__end_report 19:48:04 INFO - 2015-10-29 19:48:04,082 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173284077__endTimestamp 19:48:04 INFO - 2015-10-29 19:48:04,285 DEBUG : BROWSER_OUTPUT: [Child 2540] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:48:04 INFO - 2015-10-29 19:48:04,285 DEBUG : BROWSER_OUTPUT: [Child 2540] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:48:04 INFO - 2015-10-29 19:48:04,914 INFO : Browser exited with error code: 0 19:48:04 INFO - 2015-10-29 19:48:04,914 INFO : Running cycle 3/20 for tresize test... 19:48:04 INFO - 2015-10-29 19:48:04,914 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:48:16 INFO - 2015-10-29 19:48:16,474 DEBUG : BROWSER_OUTPUT: __start_report12.369516666666632__end_report 19:48:16 INFO - 2015-10-29 19:48:16,474 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173296470__endTimestamp 19:48:16 INFO - 2015-10-29 19:48:16,674 DEBUG : BROWSER_OUTPUT: [Child 3248] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:48:17 INFO - 2015-10-29 19:48:17,348 INFO : Browser exited with error code: 0 19:48:17 INFO - 2015-10-29 19:48:17,348 INFO : Running cycle 4/20 for tresize test... 19:48:17 INFO - 2015-10-29 19:48:17,348 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:48:29 INFO - 2015-10-29 19:48:29,010 DEBUG : BROWSER_OUTPUT: __start_report12.879483333333267__end_report 19:48:29 INFO - 2015-10-29 19:48:29,010 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173309007__endTimestamp 19:48:29 INFO - 2015-10-29 19:48:29,213 DEBUG : BROWSER_OUTPUT: [Child 1056] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:48:29 INFO - 2015-10-29 19:48:29,888 INFO : Browser exited with error code: 0 19:48:29 INFO - 2015-10-29 19:48:29,888 INFO : Running cycle 5/20 for tresize test... 19:48:29 INFO - 2015-10-29 19:48:29,888 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:48:41 INFO - 2015-10-29 19:48:41,505 DEBUG : BROWSER_OUTPUT: __start_report12.719266666666622__end_report 19:48:41 INFO - 2015-10-29 19:48:41,505 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173321505__endTimestamp 19:48:41 INFO - 2015-10-29 19:48:41,713 DEBUG : BROWSER_OUTPUT: [Child 256] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:48:41 INFO - 2015-10-29 19:48:41,713 DEBUG : BROWSER_OUTPUT: [Child 256] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:48:42 INFO - 2015-10-29 19:48:42,470 INFO : Browser exited with error code: 0 19:48:42 INFO - 2015-10-29 19:48:42,471 INFO : Running cycle 6/20 for tresize test... 19:48:42 INFO - 2015-10-29 19:48:42,471 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:48:54 INFO - 2015-10-29 19:48:54,108 DEBUG : BROWSER_OUTPUT: __start_report12.640616666666656__end_report 19:48:54 INFO - 2015-10-29 19:48:54,108 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173334106__endTimestamp 19:48:54 INFO - 2015-10-29 19:48:54,313 DEBUG : BROWSER_OUTPUT: [Child 296] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:48:54 INFO - 2015-10-29 19:48:54,313 DEBUG : BROWSER_OUTPUT: [Child 296] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:48:55 INFO - 2015-10-29 19:48:55,108 INFO : Browser exited with error code: 0 19:48:55 INFO - 2015-10-29 19:48:55,108 INFO : Running cycle 7/20 for tresize test... 19:48:55 INFO - 2015-10-29 19:48:55,108 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:49:06 INFO - 2015-10-29 19:49:06,726 DEBUG : BROWSER_OUTPUT: __start_report12.67794999999995__end_report 19:49:06 INFO - 2015-10-29 19:49:06,726 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173346721__endTimestamp 19:49:06 INFO - 2015-10-29 19:49:06,930 DEBUG : BROWSER_OUTPUT: [Child 3840] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:49:06 INFO - 2015-10-29 19:49:06,930 DEBUG : BROWSER_OUTPUT: [Child 3840] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:49:07 INFO - 2015-10-29 19:49:07,697 INFO : Browser exited with error code: 0 19:49:07 INFO - 2015-10-29 19:49:07,697 INFO : Running cycle 8/20 for tresize test... 19:49:07 INFO - 2015-10-29 19:49:07,697 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:49:19 INFO - 2015-10-29 19:49:19,302 DEBUG : BROWSER_OUTPUT: __start_report12.673066666666653__end_report 19:49:19 INFO - 2015-10-29 19:49:19,302 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173359300__endTimestamp 19:49:20 INFO - 2015-10-29 19:49:20,311 INFO : Browser exited with error code: 0 19:49:20 INFO - 2015-10-29 19:49:20,312 INFO : Running cycle 9/20 for tresize test... 19:49:20 INFO - 2015-10-29 19:49:20,312 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:49:31 INFO - 2015-10-29 19:49:31,940 DEBUG : BROWSER_OUTPUT: __start_report12.597499999999958__end_report 19:49:31 INFO - 2015-10-29 19:49:31,940 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173371937__endTimestamp 19:49:32 INFO - 2015-10-29 19:49:32,158 DEBUG : BROWSER_OUTPUT: [Child 2104] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:49:32 INFO - 2015-10-29 19:49:32,158 DEBUG : BROWSER_OUTPUT: [Child 2104] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:49:32 INFO - 2015-10-29 19:49:32,953 INFO : Browser exited with error code: 0 19:49:32 INFO - 2015-10-29 19:49:32,953 INFO : Running cycle 10/20 for tresize test... 19:49:32 INFO - 2015-10-29 19:49:32,953 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:49:44 INFO - 2015-10-29 19:49:44,542 DEBUG : BROWSER_OUTPUT: __start_report12.423900000000026__end_report 19:49:44 INFO - 2015-10-29 19:49:44,542 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173384535__endTimestamp 19:49:45 INFO - 2015-10-29 19:49:45,542 INFO : Browser exited with error code: 0 19:49:45 INFO - 2015-10-29 19:49:45,542 INFO : Running cycle 11/20 for tresize test... 19:49:45 INFO - 2015-10-29 19:49:45,542 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:49:57 INFO - 2015-10-29 19:49:57,157 DEBUG : BROWSER_OUTPUT: __start_report12.514449999999995__end_report 19:49:57 INFO - 2015-10-29 19:49:57,157 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173397148__endTimestamp 19:49:57 INFO - 2015-10-29 19:49:57,364 DEBUG : BROWSER_OUTPUT: [Child 1564] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:49:57 INFO - 2015-10-29 19:49:57,364 DEBUG : BROWSER_OUTPUT: [Child 1564] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:49:58 INFO - 2015-10-29 19:49:58,140 INFO : Browser exited with error code: 0 19:49:58 INFO - 2015-10-29 19:49:58,141 INFO : Running cycle 12/20 for tresize test... 19:49:58 INFO - 2015-10-29 19:49:58,141 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:50:09 INFO - 2015-10-29 19:50:09,773 DEBUG : BROWSER_OUTPUT: __start_report12.600800000000033__end_report 19:50:09 INFO - 2015-10-29 19:50:09,773 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173409773__endTimestamp 19:50:10 INFO - 2015-10-29 19:50:10,730 INFO : Browser exited with error code: 0 19:50:10 INFO - 2015-10-29 19:50:10,732 INFO : Running cycle 13/20 for tresize test... 19:50:10 INFO - 2015-10-29 19:50:10,732 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:50:22 INFO - 2015-10-29 19:50:22,224 DEBUG : BROWSER_OUTPUT: __start_report12.193799999999998__end_report 19:50:22 INFO - 2015-10-29 19:50:22,224 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173422222__endTimestamp 19:50:22 INFO - 2015-10-29 19:50:22,437 DEBUG : BROWSER_OUTPUT: [Child 3224] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:50:22 INFO - 2015-10-29 19:50:22,437 DEBUG : BROWSER_OUTPUT: [Child 3224] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:50:23 INFO - 2015-10-29 19:50:23,217 INFO : Browser exited with error code: 0 19:50:23 INFO - 2015-10-29 19:50:23,217 INFO : Running cycle 14/20 for tresize test... 19:50:23 INFO - 2015-10-29 19:50:23,217 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:50:34 INFO - 2015-10-29 19:50:34,865 DEBUG : BROWSER_OUTPUT: __start_report12.566883333333353__end_report 19:50:34 INFO - 2015-10-29 19:50:34,865 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173434863__endTimestamp 19:50:35 INFO - 2015-10-29 19:50:35,068 DEBUG : BROWSER_OUTPUT: [Child 2216] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:50:35 INFO - 2015-10-29 19:50:35,068 DEBUG : BROWSER_OUTPUT: [Child 2216] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:50:35 INFO - 2015-10-29 19:50:35,867 INFO : Browser exited with error code: 0 19:50:35 INFO - 2015-10-29 19:50:35,868 INFO : Running cycle 15/20 for tresize test... 19:50:35 INFO - 2015-10-29 19:50:35,868 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:50:47 INFO - 2015-10-29 19:50:47,382 DEBUG : BROWSER_OUTPUT: __start_report12.192783333333367__end_report 19:50:47 INFO - 2015-10-29 19:50:47,382 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173447379__endTimestamp 19:50:47 INFO - 2015-10-29 19:50:47,585 DEBUG : BROWSER_OUTPUT: [Child 2808] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:50:48 INFO - 2015-10-29 19:50:48,357 INFO : Browser exited with error code: 0 19:50:48 INFO - 2015-10-29 19:50:48,358 INFO : Running cycle 16/20 for tresize test... 19:50:48 INFO - 2015-10-29 19:50:48,358 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:51:00 INFO - 2015-10-29 19:51:00,058 DEBUG : BROWSER_OUTPUT: __start_report12.993783333333324__end_report 19:51:00 INFO - 2015-10-29 19:51:00,058 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173460056__endTimestamp 19:51:01 INFO - 2015-10-29 19:51:01,055 INFO : Browser exited with error code: 0 19:51:01 INFO - 2015-10-29 19:51:01,055 INFO : Running cycle 17/20 for tresize test... 19:51:01 INFO - 2015-10-29 19:51:01,055 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:51:12 INFO - 2015-10-29 19:51:12,723 DEBUG : BROWSER_OUTPUT: __start_report12.719250000000043__end_report 19:51:12 INFO - 2015-10-29 19:51:12,723 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173472719__endTimestamp 19:51:12 INFO - 2015-10-29 19:51:12,927 DEBUG : BROWSER_OUTPUT: [Child 2220] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:51:12 INFO - 2015-10-29 19:51:12,927 DEBUG : BROWSER_OUTPUT: [Child 2220] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:51:13 INFO - 2015-10-29 19:51:13,737 INFO : Browser exited with error code: 0 19:51:13 INFO - 2015-10-29 19:51:13,739 INFO : Running cycle 18/20 for tresize test... 19:51:13 INFO - 2015-10-29 19:51:13,739 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:51:25 INFO - 2015-10-29 19:51:25,434 DEBUG : BROWSER_OUTPUT: __start_report12.87009999999997__end_report 19:51:25 INFO - 2015-10-29 19:51:25,434 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173485427__endTimestamp 19:51:28 INFO - 2015-10-29 19:51:28,276 INFO : Browser exited with error code: 0 19:51:28 INFO - 2015-10-29 19:51:28,278 INFO : Running cycle 19/20 for tresize test... 19:51:28 INFO - 2015-10-29 19:51:28,278 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:51:39 INFO - 2015-10-29 19:51:39,915 DEBUG : BROWSER_OUTPUT: __start_report12.585949999999999__end_report 19:51:39 INFO - 2015-10-29 19:51:39,915 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173499915__endTimestamp 19:51:41 INFO - 2015-10-29 19:51:41,391 INFO : Browser exited with error code: 0 19:51:41 INFO - 2015-10-29 19:51:41,392 INFO : Running cycle 20/20 for tresize test... 19:51:41 INFO - 2015-10-29 19:51:41,392 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdzlv0k\profile http://localhost:49276/startup_test/tresize/addon/content/tresize-test.html 19:51:53 INFO - 2015-10-29 19:51:53,095 DEBUG : BROWSER_OUTPUT: __start_report12.841483333333333__end_report 19:51:53 INFO - 2015-10-29 19:51:53,095 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173513090__endTimestamp 19:51:53 INFO - 2015-10-29 19:51:53,457 DEBUG : BROWSER_OUTPUT: [Child 3240] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:51:53 INFO - 2015-10-29 19:51:53,457 DEBUG : BROWSER_OUTPUT: [Child 3240] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:51:54 INFO - 2015-10-29 19:51:54,835 INFO : Browser exited with error code: 0 19:51:55 INFO - 2015-10-29 19:51:55,628 INFO : Completed test tresize (00:04:26) 19:51:55 INFO - 2015-10-29 19:51:55,628 INFO : Starting test tcanvasmark 19:51:55 INFO - 2015-10-29 19:51:55,628 DEBUG : operating with platform_type : w8_ 19:51:55 INFO - 2015-10-29 19:51:55,628 INFO : Initialising browser for tcanvasmark test... 19:51:55 INFO - 2015-10-29 19:51:55,657 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmppapuyy\profile http://localhost:49276/getInfo.html 19:52:03 INFO - 2015-10-29 19:52:03,148 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:52:03 INFO - 2015-10-29 19:52:03,148 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:52:03 INFO - 2015-10-29 19:52:03,148 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 19:52:03 INFO - 2015-10-29 19:52:03,148 DEBUG : BROWSER_OUTPUT: __metrics 19:52:03 INFO - 2015-10-29 19:52:03,450 DEBUG : BROWSER_OUTPUT: [Child 2916] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:52:03 INFO - 2015-10-29 19:52:03,450 DEBUG : BROWSER_OUTPUT: [Child 2916] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:52:04 INFO - 2015-10-29 19:52:04,377 INFO : Browser initialized. 19:52:04 INFO - 2015-10-29 19:52:04,377 INFO : Running cycle 1/1 for tcanvasmark test... 19:52:04 INFO - 2015-10-29 19:52:04,377 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmppapuyy\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\canvasmark\canvasmark.manifest.develop -tpchrome -tpnoisy -tpcycles 5 -tppagecycles 1 19:52:05 INFO - 2015-10-29 19:52:05,105 DEBUG : BROWSER_OUTPUT: [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0) 19:52:16 INFO - 2015-10-29 19:52:16,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 180027392 19:52:16 INFO - 2015-10-29 19:52:16,078 DEBUG : BROWSER_OUTPUT: 19:53:05 INFO - 2015-10-29 19:53:05,753 DEBUG : BROWSER_OUTPUT: 1446173585750 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:53:35 INFO - 2015-10-29 19:53:35,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/canvasmark/index.html?auto=true (next: http://localhost:49276/tests/canvasmark/index.html?auto=true) 19:53:36 INFO - 2015-10-29 19:53:36,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 164610048 19:53:36 INFO - 2015-10-29 19:53:36,124 DEBUG : BROWSER_OUTPUT: 19:53:36 INFO - 2015-10-29 19:53:36,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 164610048 19:53:36 INFO - 2015-10-29 19:53:36,377 DEBUG : BROWSER_OUTPUT: 19:54:54 INFO - 2015-10-29 19:54:54,493 DEBUG : BROWSER_OUTPUT: Cycle 2(1): loaded http://localhost:49276/tests/canvasmark/index.html?auto=true (next: http://localhost:49276/tests/canvasmark/index.html?auto=true) 19:54:54 INFO - 2015-10-29 19:54:54,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 140017664 19:54:54 INFO - 2015-10-29 19:54:54,752 DEBUG : BROWSER_OUTPUT: 19:54:55 INFO - 2015-10-29 19:54:54,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 139636736 19:54:55 INFO - 2015-10-29 19:54:54,997 DEBUG : BROWSER_OUTPUT: 19:56:12 INFO - 2015-10-29 19:56:12,394 DEBUG : BROWSER_OUTPUT: Cycle 3(1): loaded http://localhost:49276/tests/canvasmark/index.html?auto=true (next: http://localhost:49276/tests/canvasmark/index.html?auto=true) 19:56:12 INFO - 2015-10-29 19:56:12,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 123097088 19:56:12 INFO - 2015-10-29 19:56:12,642 DEBUG : BROWSER_OUTPUT: 19:56:12 INFO - 2015-10-29 19:56:12,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 122777600 19:56:12 INFO - 2015-10-29 19:56:12,897 DEBUG : BROWSER_OUTPUT: 19:57:29 INFO - 2015-10-29 19:57:29,680 DEBUG : BROWSER_OUTPUT: Cycle 4(1): loaded http://localhost:49276/tests/canvasmark/index.html?auto=true (next: http://localhost:49276/tests/canvasmark/index.html?auto=true) 19:57:29 INFO - 2015-10-29 19:57:29,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 122380288 19:57:29 INFO - 2015-10-29 19:57:29,934 DEBUG : BROWSER_OUTPUT: 19:57:30 INFO - 2015-10-29 19:57:30,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 122380288 19:57:30 INFO - 2015-10-29 19:57:30,183 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,242 DEBUG : BROWSER_OUTPUT: Cycle 5(1): loaded http://localhost:49276/tests/canvasmark/index.html?auto=true (next: http://localhost:49276/tests/canvasmark/index.html?auto=true) 19:58:53 INFO - 2015-10-29 19:58:53,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 108843008 19:58:53 INFO - 2015-10-29 19:58:53,494 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,494 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:58:53 INFO - 2015-10-29 19:58:53,494 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:58:53 INFO - 2015-10-29 19:58:53,494 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:58:53 INFO - 2015-10-29 19:58:53,494 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:58:53 INFO - 2015-10-29 19:58:53,494 DEBUG : BROWSER_OUTPUT: |0;Asteroids - Bitmaps;1138;1042;995;950;1503 19:58:53 INFO - 2015-10-29 19:58:53,494 DEBUG : BROWSER_OUTPUT: |1;Asteroids - Vectors;1462;1553;1521;1494;1518 19:58:53 INFO - 2015-10-29 19:58:53,494 DEBUG : BROWSER_OUTPUT: |2;Asteroids - Bitmaps- shapes- text;276;286;286;280;282 19:58:53 INFO - 2015-10-29 19:58:53,494 DEBUG : BROWSER_OUTPUT: |3;Asteroids - Shapes- shadows- blending;602;617;617;622;625 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: |4;Arena5 - Vectors- shadows- bitmaps- text;361;339;338;332;335 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: |5;Plasma - Maths- canvas shapes;1285;1291;1266;1293;1306 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: |6;3D Rendering - Maths- polygons- image transforms;1565;1520;1526;1518;1562 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: |7;Pixel blur - Math- getImageData- putImageData;1681;1700;1727;1695;1695 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: __startTimestamp1446173933491__endTimestamp 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: Number of tests: 8 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: [#0] Asteroids - Bitmaps Cycles:5 Average:1125.60 Median:1503.00 stddev:222.19 (14.8%) stddev-sans-first:256.43 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: Values: 1138.0 1042.0 995.0 950.0 1503.0 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: [#1] Asteroids - Vectors Cycles:5 Average:1509.60 Median:1518.00 stddev:33.89 (2.2%) stddev-sans-first:24.23 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: Values: 1462.0 1553.0 1521.0 1494.0 1518.0 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: [#2] Asteroids - Bitmaps- shapes- text Cycles:5 Average:282.00 Median:282.00 stddev:4.24 (1.5%) stddev-sans-first:3.00 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: Values: 276.0 286.0 286.0 280.0 282.0 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: [#3] Asteroids - Shapes- shadows- blending Cycles:5 Average:616.60 Median:617.00 stddev:8.85 (1.4%) stddev-sans-first:3.95 19:58:53 INFO - 2015-10-29 19:58:53,496 DEBUG : BROWSER_OUTPUT: Values: 602.0 617.0 617.0 622.0 625.0 19:58:53 INFO - 2015-10-29 19:58:53,497 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,497 DEBUG : BROWSER_OUTPUT: [#4] Arena5 - Vectors- shadows- bitmaps- text Cycles:5 Average:341.00 Median:338.00 stddev:11.51 (3.4%) stddev-sans-first:3.16 19:58:53 INFO - 2015-10-29 19:58:53,497 DEBUG : BROWSER_OUTPUT: Values: 361.0 339.0 338.0 332.0 335.0 19:58:53 INFO - 2015-10-29 19:58:53,497 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,497 DEBUG : BROWSER_OUTPUT: [#5] Plasma - Maths- canvas shapes Cycles:5 Average:1288.20 Median:1291.00 stddev:14.58 (1.1%) stddev-sans-first:16.71 19:58:53 INFO - 2015-10-29 19:58:53,497 DEBUG : BROWSER_OUTPUT: Values: 1285.0 1291.0 1266.0 1293.0 1306.0 19:58:53 INFO - 2015-10-29 19:58:53,497 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,497 DEBUG : BROWSER_OUTPUT: [#6] 3D Rendering - Maths- polygons- image transforms Cycles:5 Average:1538.20 Median:1526.00 stddev:23.31 (1.5%) stddev-sans-first:20.62 19:58:53 INFO - 2015-10-29 19:58:53,497 DEBUG : BROWSER_OUTPUT: Values: 1565.0 1520.0 1526.0 1518.0 1562.0 19:58:53 INFO - 2015-10-29 19:58:53,497 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,497 DEBUG : BROWSER_OUTPUT: [#7] Pixel blur - Math- getImageData- putImageData Cycles:5 Average:1699.60 Median:1695.00 stddev:16.88 (1.0%) stddev-sans-first:15.35 19:58:53 INFO - 2015-10-29 19:58:53,499 DEBUG : BROWSER_OUTPUT: Values: 1681.0 1700.0 1727.0 1695.0 1695.0 19:58:53 INFO - 2015-10-29 19:58:53,499 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:58:53 INFO - 2015-10-29 19:58:53,499 DEBUG : BROWSER_OUTPUT: 19:58:53 INFO - 2015-10-29 19:58:53,650 DEBUG : BROWSER_OUTPUT: [Child 3816] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:58:53 INFO - 2015-10-29 19:58:53,650 DEBUG : BROWSER_OUTPUT: [Child 3816] WARNING: pipe error: 109: file c:/builds/moz2_slave/fx-team-w64-000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 333 19:58:54 INFO - 2015-10-29 19:58:54,191 INFO : Browser exited with error code: 0 19:58:54 INFO - 2015-10-29 19:58:54,882 INFO : Completed test tcanvasmark (00:06:59) 19:58:55 INFO - 2015-10-29 19:58:55,200 INFO : Completed test suite (00:11:26) 19:58:55 INFO - 2015-10-29 19:58:55,200 DEBUG : Working with test: tresize 19:58:55 INFO - 2015-10-29 19:58:55,200 DEBUG : Generating results file: tresize 19:58:55 INFO - 2015-10-29 19:58:55,200 DEBUG : Working with test: tcanvasmark 19:58:55 INFO - 2015-10-29 19:58:55,200 DEBUG : Generating results file: tcanvasmark 19:58:55 INFO - 2015-10-29 19:58:55,200 INFO : CanvasMark benchmark 19:58:55 INFO - 2015-10-29 19:58:55,200 INFO : Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:58:55 INFO - 2015-10-29 19:58:55,256 DEBUG : process_Request line: tresize graph.html#tests=[[254,132,49]] 19:58:55 INFO - 2015-10-29 19:58:55,256 DEBUG : process_Request line: tresize 12.66 graph.html#tests=[[254,132,49]] 19:58:55 INFO - 2015-10-29 19:58:55,256 INFO : Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:58:55 INFO - 2015-10-29 19:58:55,286 DEBUG : process_Request line: tcanvasmark 8290.50 graph.html#tests=[[289,132,49]] 19:58:55 INFO - 2015-10-29 19:58:55,286 INFO : CanvasMark benchmark 19:58:55 INFO - 2015-10-29 19:58:55,286 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"tresize": [13.392966666666652, 12.796166666666673, 12.369516666666632, 12.879483333333267, 12.719266666666622, 12.640616666666656, 12.67794999999995, 12.673066666666653, 12.597499999999958, 12.423900000000026, 12.514449999999995, 12.600800000000033, 12.193799999999998, 12.566883333333353, 12.192783333333367, 12.993783333333324, 12.719250000000043, 12.87009999999997, 12.585949999999999, 12.841483333333333]}, "summary": {"suite": 12.600800000000033, "subtests": {"tresize": {"filtered": 12.600800000000033, "value": 12.600800000000033}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200.e", "os": "win", "name": "T-W864-IX-184.e"}, "testrun": {"date": 1446173248, "suite": "tresize", "options": {"responsiveness": false, "cycles": 20, "tpmozafterpaint": true, "shutdown": false, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151029171013", "branch": "Fx-Team-Non-PGO", "revision": "5cdf66dfef92364072336ce276f9f2c70d421718"}}, {"talos_counters": {}, "results": {"Plasma - Maths- canvas shapes": [1285.0, 1291.0, 1266.0, 1293.0, 1306.0], "Asteroids - Shapes- shadows- blending": [602.0, 617.0, 617.0, 622.0, 625.0], "Asteroids - Bitmaps- shapes- text": [276.0, 286.0, 286.0, 280.0, 282.0], "Arena5 - Vectors- shadows- bitmaps- text": [361.0, 339.0, 338.0, 332.0, 335.0], "Asteroids - Vectors": [1462.0, 1553.0, 1521.0, 1494.0, 1518.0], "3D Rendering - Maths- polygons- image transforms": [1565.0, 1520.0, 1526.0, 1518.0, 1562.0], "Pixel blur - Math- getImageData- putImageData": [1681.0, 1700.0, 1727.0, 1695.0, 1695.0], "Asteroids - Bitmaps": [1138.0, 1042.0, 995.0, 950.0, 1503.0]}, "summary": {"suite": 8290.5, "subtests": {"Plasma - Maths- canvas shapes": {"filtered": 1292.0, "value": 1292.0}, "Asteroids - Shapes- shadows- blending": {"filtered": 619.5, "value": 619.5}, "Asteroids - Bitmaps- shapes- text": {"filtered": 284.0, "value": 284.0}, "Arena5 - Vectors- shadows- bitmaps- text": {"filtered": 336.5, "value": 336.5}, "Asteroids - Vectors": {"filtered": 1519.5, "value": 1519.5}, "3D Rendering - Maths- polygons- image transforms": {"filtered": 1523.0, "value": 1523.0}, "Pixel blur - Math- getImageData- putImageData": {"filtered": 1697.5, "value": 1697.5}, "Asteroids - Bitmaps": {"filtered": 1018.5, "value": 1018.5}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200.e", "os": "win", "name": "T-W864-IX-184.e"}, "testrun": {"date": 1446173248, "suite": "tcanvasmark", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 5, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151029171013", "branch": "Fx-Team-Non-PGO", "revision": "5cdf66dfef92364072336ce276f9f2c70d421718"}}] 19:58:55 INFO - RETURN: tresize: 12.66 19:58:55 INFO - RETURN: tcanvasmark: 8290.50 19:58:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"tcanvasmark": {"url": "http://graphs.mozilla.org/graph.html#tests=[[289,132,49]]", "result": "8290.50"}, "tresize": {"url": "http://graphs.mozilla.org/graph.html#tests=[[254,132,49]]", "result": "12.66"}}} 19:58:55 INFO - Return code: 0 19:58:55 INFO - # TBPL SUCCESS # 19:58:55 INFO - Running post-action listener: _resource_record_post_action 19:58:55 INFO - Running post-run listener: _resource_record_post_run 19:58:56 INFO - Total resource usage - Wall time: 689s; CPU: 13.0%; Read bytes: 777677824; Write bytes: 852355584; Read time: 5363980; Write time: 7122920 19:58:56 INFO - install - Wall time: 2s; CPU: 10.0%; Read bytes: 0; Write bytes: 3109888; Read time: 0; Write time: 110710 19:58:56 INFO - run-tests - Wall time: 688s; CPU: 13.0%; Read bytes: 777677824; Write bytes: 815924736; Read time: 5363980; Write time: 6983440 19:58:56 INFO - Running post-run listener: _upload_blobber_files 19:58:56 INFO - Blob upload gear active. 19:58:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:58:56 INFO - Copying logs to upload dir... 19:58:56 INFO - mkdir: C:\slave\test\build\upload\logs program finished with exit code 0 elapsedTime=846.768000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 14 mins, 20 secs) (at 2015-10-29 19:59:09.721509) ========= ========= Started set props: build_url (results: 0, elapsed: 11 secs) (at 2015-10-29 19:59:09.722252) ========= '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.T-W864-IX-184\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-184 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-184 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-184\AppData\Local LOGONSERVER=\\T-W864-IX-184 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\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 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=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~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-184 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-184 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-184 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False build_url:https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/v2VxVDAxSy-PZvsOTvyIsA/artifacts/public/build/firefox-45.0a1.en-US.win64.zip' ========= Finished set props: build_url (results: 0, elapsed: 11 secs) (at 2015-10-29 19:59:20.936115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2015-10-29 19:59:20.936472) ========= '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.T-W864-IX-184\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-184 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-184 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-184\AppData\Local LOGONSERVER=\\T-W864-IX-184 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\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 PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=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~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-184 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-184 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-184 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.100000 ========= Finished 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2015-10-29 19:59:31.869864) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-29 19:59:31.870277) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-29 19:59:32.440300) =========