builder: graphics_win8_64_test-dromaeojs slave: t-w864-ix-095 starttime: 1480041973.45 results: success (0) buildid: 20161124171918 builduid: 4e78a480ffe0489ea343eb44fc7ed19f revision: 2f27eb71f5234f424c0e12a73df2ed89410cc12e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 18:46:13.451788) ========= master: http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 18:46:13.452212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 18:46:13.452490) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 18:46:13.562466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 18:46:13.562733) ========= '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-095\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-095 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-095 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-095\AppData\Local LOGONSERVER=\\T-W864-IX-095 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;C:\mozilla-build\hg 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-095 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-095 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-095 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --18:46:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure HTTP request sent, awaiting response... 200 Script output follows Length: 12,179 (12K) [text/x-python] 0K .......... . 100% 2.46 GB/s 18:46:14 (2.46 GB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.176000 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 18:46:14.805346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-11-24 18:46:14.805656) ========= 'rm' '-rf' 'scripts' 'properties' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-095\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-095 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-095 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-095\AppData\Local LOGONSERVER=\\T-W864-IX-095 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;C:\mozilla-build\hg 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-095 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-095 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-095 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.507000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-11-24 18:46:17.335226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 18:46:17.335579) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo projects/graphics --rev 2f27eb71f5234f424c0e12a73df2ed89410cc12e --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 2f27eb71f5234f424c0e12a73df2ed89410cc12e --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-095\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-095 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-095 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-095\AppData\Local LOGONSERVER=\\T-W864-IX-095 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;C:\mozilla-build\hg 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-095 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-095 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-095 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-11-24 18:46:17,680 truncating revision to first 12 chars 2016-11-24 18:46:17,680 Setting DEBUG logging. 2016-11-24 18:46:17,680 attempt 1/10 2016-11-24 18:46:17,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/2f27eb71f523?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 18:46:18,114 unpacking tar archive at: graphics-2f27eb71f523/testing/mozharness/ 2016-11-24 18:46:18,266 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.146000 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 18:46:18.528216) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 18:46:18.528521) ========= script_repo_revision: 2f27eb71f5234f424c0e12a73df2ed89410cc12e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 18:46:18.528904) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 18:46:18.529198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 18:46:18.551460) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 51 secs) (at 2016-11-24 18:46:18.551854) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Graphics' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Graphics' 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', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-095\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-095 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-095 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-095\AppData\Local LOGONSERVER=\\T-W864-IX-095 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;C:\mozilla-build\hg 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-095 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-095 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-095 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 18:46:19 INFO - MultiFileLogger online at 20161124 18:46:19 in C:\slave\test 18:46:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 18:46:19 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 18:46:19 INFO - {'append_to_log': False, 18:46:19 INFO - 'base_work_dir': 'C:\\slave\\test', 18:46:19 INFO - 'blob_upload_branch': 'Graphics', 18:46:19 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 18:46:19 INFO - 'branch': 'Graphics', 18:46:19 INFO - 'buildbot_json_path': 'buildprops.json', 18:46:19 INFO - 'config_files': ('talos/windows_config.py',), 18:46:19 INFO - 'default_actions': ('clobber', 18:46:19 INFO - 'read-buildbot-config', 18:46:19 INFO - 'download-and-extract', 18:46:19 INFO - 'populate-webroot', 18:46:19 INFO - 'create-virtualenv', 18:46:19 INFO - 'install', 18:46:19 INFO - 'run-tests'), 18:46:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:46:19 INFO - 'download_minidump_stackwalk': True, 18:46:19 INFO - 'download_symbols': 'ondemand', 18:46:19 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 18:46:19 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 18:46:19 INFO - 'hg': 'c:/mozilla-build/hg/hg', 18:46:19 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 18:46:19 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 18:46:19 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 18:46:19 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 18:46:19 INFO - 'C:/mozilla-build/tooltool.py'), 18:46:19 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 18:46:19 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 18:46:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:46:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:46:19 INFO - 'installer_path': 'installer.exe', 18:46:19 INFO - 'log_level': 'info', 18:46:19 INFO - 'log_name': 'talos', 18:46:19 INFO - 'log_to_console': True, 18:46:19 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 18:46:19 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 18:46:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 18:46:19 INFO - 'opt_config_files': (), 18:46:19 INFO - 'pip_index': False, 18:46:19 INFO - 'sps_profile': False, 18:46:19 INFO - 'sps_profile_interval': 0, 18:46:19 INFO - 'suite': 'dromaeojs', 18:46:19 INFO - 'system_bits': '32', 18:46:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:46:19 INFO - 'title': 'T-W864-IX-095', 18:46:19 INFO - 'use_talos_json': True, 18:46:19 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 18:46:19 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 18:46:19 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 18:46:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:46:19 INFO - 'work_dir': 'build'} 18:46:19 INFO - [mozharness: 2016-11-25 02:46:19.130000Z] Running clobber step. 18:46:19 INFO - Running pre-action listener: _resource_record_pre_action 18:46:19 INFO - Running main action method: clobber 18:46:19 INFO - rmtree: C:\slave\test\build 18:46:19 INFO - Using _rmtree_windows ... 18:46:19 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 18:47:41 INFO - Running post-action listener: _resource_record_post_action 18:47:41 INFO - [mozharness: 2016-11-25 02:47:41.720000Z] Finished clobber step (success) 18:47:41 INFO - [mozharness: 2016-11-25 02:47:41.720000Z] Running read-buildbot-config step. 18:47:41 INFO - Running pre-action listener: _resource_record_pre_action 18:47:41 INFO - Running main action method: read_buildbot_config 18:47:41 INFO - Using buildbot properties: 18:47:41 INFO - { 18:47:41 INFO - "project": "", 18:47:41 INFO - "product": "firefox", 18:47:41 INFO - "script_repo_revision": "default", 18:47:41 INFO - "builddir": "graphics_win8_64_test-dromaeojs", 18:47:41 INFO - "repository": "", 18:47:41 INFO - "buildername": "Windows 8 64-bit graphics talos dromaeojs", 18:47:41 INFO - "buildid": "20161124171918", 18:47:41 INFO - "pgo_build": "False", 18:47:41 INFO - "basedir": "C:\\slave\\test", 18:47:41 INFO - "buildnumber": 4, 18:47:41 INFO - "slavename": "t-w864-ix-095", 18:47:41 INFO - "master": "http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/", 18:47:41 INFO - "platform": "win8_64", 18:47:41 INFO - "scheduler": "tests-graphics-win64-talos", 18:47:41 INFO - "branch": "graphics", 18:47:41 INFO - "repo_path": "projects/graphics", 18:47:41 INFO - "revision": "2f27eb71f5234f424c0e12a73df2ed89410cc12e", 18:47:41 INFO - "stage_platform": "win64", 18:47:41 INFO - "builduid": "4e78a480ffe0489ea343eb44fc7ed19f", 18:47:41 INFO - "slavebuilddir": "test" 18:47:41 INFO - } 18:47:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip. 18:47:41 INFO - Running post-action listener: _resource_record_post_action 18:47:41 INFO - [mozharness: 2016-11-25 02:47:41.723000Z] Finished read-buildbot-config step (success) 18:47:41 INFO - [mozharness: 2016-11-25 02:47:41.723000Z] Running download-and-extract step. 18:47:41 INFO - Running pre-action listener: _resource_record_pre_action 18:47:41 INFO - Running main action method: download_and_extract 18:47:41 INFO - mkdir: C:\slave\test\build\tests 18:47:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:41 INFO - trying https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.test_packages.json 18:47:41 INFO - Downloading https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-53.0a1.en-US.win64.test_packages.json 18:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-53.0a1.en-US.win64.test_packages.json'}, attempt #1 18:47:42 INFO - Downloaded 1274 bytes. 18:47:42 INFO - Reading from file C:\slave\test\build\firefox-53.0a1.en-US.win64.test_packages.json 18:47:42 INFO - Using the following test package requirements: 18:47:42 INFO - {u'common': [u'firefox-53.0a1.en-US.win64.common.tests.zip'], 18:47:42 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 18:47:42 INFO - u'firefox-53.0a1.en-US.win64.cppunittest.tests.zip'], 18:47:42 INFO - u'gtest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 18:47:42 INFO - u'firefox-53.0a1.en-US.win64.gtest.tests.zip'], 18:47:42 INFO - u'jittest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 18:47:42 INFO - u'jsshell-win64.zip'], 18:47:42 INFO - u'mochitest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 18:47:42 INFO - u'firefox-53.0a1.en-US.win64.mochitest.tests.zip'], 18:47:42 INFO - u'mozbase': [u'firefox-53.0a1.en-US.win64.common.tests.zip'], 18:47:42 INFO - u'reftest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 18:47:42 INFO - u'firefox-53.0a1.en-US.win64.reftest.tests.zip'], 18:47:42 INFO - u'talos': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 18:47:42 INFO - u'firefox-53.0a1.en-US.win64.talos.tests.zip'], 18:47:42 INFO - u'web-platform': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 18:47:42 INFO - u'firefox-53.0a1.en-US.win64.web-platform.tests.zip'], 18:47:42 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 18:47:42 INFO - u'firefox-53.0a1.en-US.win64.xpcshell.tests.zip']} 18:47:42 INFO - Downloading packages: [u'firefox-53.0a1.en-US.win64.common.tests.zip'] for test suite category: common 18:47:42 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip 18:47:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip'}, attempt #1 18:47:42 INFO - Fetch https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip into memory 18:47:43 INFO - Http code: 200 18:47:43 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 18:47:43 INFO - x-amz-cf-id: 2glSIm8i4rxKo_EEiWF-CVF1TTsPcZq7Jz1ddewENRdqkEzb5DGZ6A== 18:47:43 INFO - x-amz-version-id: MIBmNOiQXkuC3JAe17ku8brj0tpB2SVu 18:47:43 INFO - Expected file size: 17147917 18:47:43 INFO - Obtained file size: 17147917 18:48:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.win64.common.tests.zip', u'firefox-53.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 18:48:03 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip 18:48:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip'}, attempt #1 18:48:03 INFO - Fetch https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip into memory 18:48:04 INFO - Http code: 200 18:48:04 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 18:48:04 INFO - x-amz-cf-id: X07S9nEQ4hX2lND3sS1OG1_QyLPZWpffgjMk4AcrFeGBN-JSGE5vTQ== 18:48:04 INFO - x-amz-version-id: MIBmNOiQXkuC3JAe17ku8brj0tpB2SVu 18:48:04 INFO - Expected file size: 17147917 18:48:04 INFO - Obtained file size: 17147917 18:48:13 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip 18:48:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip'}, attempt #1 18:48:13 INFO - Fetch https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip into memory 18:48:13 INFO - Http code: 200 18:48:13 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 18:48:13 INFO - x-amz-cf-id: 474ZGTJrv0u_GEZScq4o2Pq-KoOz3AdpFwssUcdxU3Xpm9O1PQ_H4w== 18:48:13 INFO - x-amz-version-id: urvjugBEiwdcpZWbskb2NFMMi4Z8npAD 18:48:14 INFO - Expected file size: 14409506 18:48:14 INFO - Obtained file size: 14409506 18:48:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:21 INFO - trying https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 18:48:21 INFO - Downloading https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip to C:\slave\test\build\firefox-53.0a1.en-US.win64.zip 18:48:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-53.0a1.en-US.win64.zip'}, attempt #1 18:48:23 INFO - Downloaded 57308963 bytes. 18:48:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 18:48:23 INFO - mkdir: C:\slave\test\properties 18:48:23 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 18:48:23 INFO - Writing to file C:\slave\test\properties\build_url 18:48:23 INFO - Contents: 18:48:23 INFO - build_url:https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 18:48:23 INFO - Running post-action listener: _resource_record_post_action 18:48:23 INFO - Running post-action listener: set_extra_try_arguments 18:48:23 INFO - [mozharness: 2016-11-25 02:48:23.951000Z] Finished download-and-extract step (success) 18:48:23 INFO - [mozharness: 2016-11-25 02:48:23.951000Z] Running populate-webroot step. 18:48:23 INFO - Running pre-action listener: _resource_record_pre_action 18:48:23 INFO - Running main action method: populate_webroot 18:48:23 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 18:48:23 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 18:48:23 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 18:48:23 INFO - u'--tppagecycles', 18:48:23 INFO - u'7'], 18:48:23 INFO - u'tests': [u'tsvgm']}}, 18:48:23 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 18:48:23 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 18:48:23 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 18:48:23 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 18:48:23 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 18:48:23 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 18:48:23 INFO - u'g1': {u'pagesets_name': u'tp5n.zip', 18:48:23 INFO - u'talos_options': [u'--disable-e10s'], 18:48:23 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 18:48:23 INFO - u'g1-e10s': {u'pagesets_name': u'tp5n.zip', 18:48:23 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 18:48:23 INFO - u'g2': {u'pagesets_name': u'tp5n.zip', 18:48:23 INFO - u'talos_options': [u'--disable-e10s'], 18:48:23 INFO - u'tests': [u'damp', u'tps']}, 18:48:23 INFO - u'g2-e10s': {u'pagesets_name': u'tp5n.zip', 18:48:23 INFO - u'tests': [u'damp', u'tps']}, 18:48:23 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 18:48:23 INFO - u'tests': [u'dromaeo_dom']}, 18:48:23 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 18:48:23 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 18:48:23 INFO - u'tests': [u'basic_compositor_video']}, 18:48:23 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 18:48:23 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 18:48:23 INFO - u'tests': [u'a11yr', 18:48:23 INFO - u'ts_paint', 18:48:23 INFO - u'tpaint', 18:48:23 INFO - u'sessionrestore', 18:48:23 INFO - u'sessionrestore_no_auto_restore', 18:48:23 INFO - u'tabpaint']}, 18:48:23 INFO - u'other-e10s': {u'tests': [u'a11yr', 18:48:23 INFO - u'ts_paint', 18:48:23 INFO - u'tpaint', 18:48:23 INFO - u'sessionrestore', 18:48:23 INFO - u'sessionrestore_no_auto_restore', 18:48:23 INFO - u'tabpaint']}, 18:48:23 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 18:48:23 INFO - u'ts_paint', 18:48:23 INFO - u'tpaint', 18:48:23 INFO - u'sessionrestore', 18:48:23 INFO - u'sessionrestore_no_auto_restore', 18:48:23 INFO - u'tabpaint']}, 18:48:23 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 18:48:23 INFO - u'ts_paint', 18:48:23 INFO - u'tpaint', 18:48:23 INFO - u'sessionrestore', 18:48:23 INFO - u'sessionrestore_no_auto_restore', 18:48:23 INFO - u'tabpaint']}, 18:48:23 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 18:48:23 INFO - u'tests': [u'a11yr', 18:48:23 INFO - u'ts_paint', 18:48:23 INFO - u'tpaint', 18:48:23 INFO - u'sessionrestore', 18:48:23 INFO - u'sessionrestore_no_auto_restore', 18:48:23 INFO - u'tabpaint']}, 18:48:23 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 18:48:23 INFO - u'tests': [u'a11yr', 18:48:23 INFO - u'ts_paint', 18:48:23 INFO - u'tpaint', 18:48:23 INFO - u'sessionrestore', 18:48:23 INFO - u'sessionrestore_no_auto_restore', 18:48:23 INFO - u'tabpaint']}, 18:48:23 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 18:48:23 INFO - u'tests': [u'tsvgx', 18:48:23 INFO - u'tsvgr_opacity', 18:48:23 INFO - u'tart', 18:48:23 INFO - u'tscrollx', 18:48:23 INFO - u'cart']}, 18:48:23 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 18:48:23 INFO - u'tsvgr_opacity', 18:48:23 INFO - u'tart', 18:48:23 INFO - u'tscrollx', 18:48:23 INFO - u'cart']}, 18:48:23 INFO - u'tp5o': {u'pagesets_name': u'tp5n.zip', 18:48:23 INFO - u'talos_options': [u'--disable-e10s'], 18:48:23 INFO - u'tests': [u'tp5o']}, 18:48:23 INFO - u'tp5o-e10s': {u'pagesets_name': u'tp5n.zip', 18:48:23 INFO - u'tests': [u'tp5o']}, 18:48:23 INFO - u'xperf': {u'pagesets_name': u'tp5n.zip', 18:48:23 INFO - u'talos_options': [u'--disable-e10s', 18:48:23 INFO - u'--xperf_path', 18:48:23 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:23 INFO - u'tests': [u'tp5n']}, 18:48:23 INFO - u'xperf-e10s': {u'pagesets_name': u'tp5n.zip', 18:48:23 INFO - u'talos_options': [u'--xperf_path', 18:48:23 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:23 INFO - u'tests': [u'tp5n']}}, 18:48:23 INFO - u'talos.zip': {u'path': u'', 18:48:23 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:48:23 INFO - Running post-action listener: _resource_record_post_action 18:48:23 INFO - [mozharness: 2016-11-25 02:48:23.987000Z] Finished populate-webroot step (success) 18:48:23 INFO - [mozharness: 2016-11-25 02:48:23.987000Z] Running create-virtualenv step. 18:48:23 INFO - Running pre-action listener: _resource_record_pre_action 18:48:23 INFO - Running main action method: create_virtualenv 18:48:23 INFO - Creating virtualenv C:\slave\test\build/venv 18:48:23 INFO - mkdir: C:\slave\test\build\venv\Scripts 18:48:23 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 18:48:23 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'! 18:48:23 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 18:48:23 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 18:48:30 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 18:48:33 INFO - Installing distribute......................................................................................................................................................................................done. 18:48:34 INFO - Return code: 0 18:48:34 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 18:48:34 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 18:48:35 INFO - Reading from file tmpfile_stdout 18:48:35 INFO - Output received: 18:48:35 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 18:48:35 INFO - Using _rmtree_windows ... 18:48:35 INFO - Using _rmtree_windows ... 18:48:35 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 18:48:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:35 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 0x02318640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028BE020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E2EC00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C0E90>, '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 0x01D9A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A25C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-095', 'USERDOMAIN': 'T-W864-IX-095', '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-095', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-095', '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;C:\\mozilla-build\\hg', '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-095\\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 18:48:35 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 18:48:35 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --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 18:48:35 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:48:35 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Roaming', 18:48:35 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:48:35 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:48:35 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:48:35 INFO - 'COMPUTERNAME': 'T-W864-IX-095', 18:48:35 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:48:35 INFO - 'DCLOCATION': 'SCL3', 18:48:35 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:48:35 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:48:35 INFO - 'HOMEDRIVE': 'C:', 18:48:35 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 18:48:35 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:48:35 INFO - 'KTS_VERSION': '1.19c', 18:48:35 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 18:48:35 INFO - 'LOGONSERVER': '\\\\T-W864-IX-095', 18:48:35 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:48:35 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:35 INFO - 'MOZ_NO_REMOTE': '1', 18:48:35 INFO - 'NO_EM_RESTART': '1', 18:48:35 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:48:35 INFO - 'OS': 'Windows_NT', 18:48:35 INFO - 'OURDRIVE': 'C:', 18:48:35 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;C:\\mozilla-build\\hg', 18:48:35 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:48:35 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:48:35 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:48:35 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:48:35 INFO - 'PROCESSOR_LEVEL': '6', 18:48:35 INFO - 'PROCESSOR_REVISION': '1e05', 18:48:35 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:48:35 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:48:35 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:48:35 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:48:35 INFO - 'PROMPT': '$P$G', 18:48:35 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 18:48:35 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:48:35 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:48:35 INFO - 'PWD': 'C:\\slave\\test', 18:48:35 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:48:35 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:48:35 INFO - 'SYSTEMDRIVE': 'C:', 18:48:35 INFO - 'SYSTEMROOT': 'C:\\windows', 18:48:35 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:35 INFO - 'TEST1': 'testie', 18:48:35 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:35 INFO - 'USERDOMAIN': 'T-W864-IX-095', 18:48:35 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 18:48:35 INFO - 'USERNAME': 'cltbld', 18:48:35 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-095', 18:48:35 INFO - 'WINDIR': 'C:\\windows', 18:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:48:35 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:48:35 INFO - Downloading/unpacking pip>=1.5 18:48:40 INFO - Running setup.py egg_info for package pip 18:48:40 INFO - warning: no files found matching 'pip\cacert.pem' 18:48:40 INFO - warning: no files found matching '*.html' under directory 'docs' 18:48:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 18:48:40 INFO - no previously-included directories found matching 'docs\_build\_sources' 18:48:40 INFO - Installing collected packages: pip 18:48:40 INFO - Found existing installation: pip 0.8.2 18:48:40 INFO - Uninstalling pip: 18:48:40 INFO - Successfully uninstalled pip 18:48:40 INFO - Running setup.py install for pip 18:48:40 INFO - warning: no files found matching 'pip\cacert.pem' 18:48:40 INFO - warning: no files found matching '*.html' under directory 'docs' 18:48:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 18:48:40 INFO - no previously-included directories found matching 'docs\_build\_sources' 18:48:40 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 18:48:40 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 18:48:40 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 18:48:40 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 18:48:40 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 18:48:40 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 18:48:40 INFO - Successfully installed pip 18:48:40 INFO - Cleaning up... 18:48:40 INFO - Return code: 0 18:48:40 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 18:48:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:40 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02318640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028BE020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E2EC00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C0E90>, '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 0x01D9A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A25C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-095', 'USERDOMAIN': 'T-W864-IX-095', '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-095', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-095', '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;C:\\mozilla-build\\hg', '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-095\\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 18:48:40 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build 18:48:40 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:48:40 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:48:40 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Roaming', 18:48:40 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:48:40 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:48:40 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:48:40 INFO - 'COMPUTERNAME': 'T-W864-IX-095', 18:48:40 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:48:40 INFO - 'DCLOCATION': 'SCL3', 18:48:40 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:48:40 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:48:40 INFO - 'HOMEDRIVE': 'C:', 18:48:40 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 18:48:40 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:48:40 INFO - 'KTS_VERSION': '1.19c', 18:48:40 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 18:48:40 INFO - 'LOGONSERVER': '\\\\T-W864-IX-095', 18:48:40 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:48:40 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:40 INFO - 'MOZ_NO_REMOTE': '1', 18:48:40 INFO - 'NO_EM_RESTART': '1', 18:48:40 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:48:40 INFO - 'OS': 'Windows_NT', 18:48:40 INFO - 'OURDRIVE': 'C:', 18:48:40 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;C:\\mozilla-build\\hg', 18:48:40 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:48:40 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:48:40 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:48:40 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:48:40 INFO - 'PROCESSOR_LEVEL': '6', 18:48:40 INFO - 'PROCESSOR_REVISION': '1e05', 18:48:40 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:48:40 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:48:40 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:48:40 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:48:40 INFO - 'PROMPT': '$P$G', 18:48:40 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 18:48:40 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:48:40 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:48:40 INFO - 'PWD': 'C:\\slave\\test', 18:48:40 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:48:40 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:48:40 INFO - 'SYSTEMDRIVE': 'C:', 18:48:40 INFO - 'SYSTEMROOT': 'C:\\windows', 18:48:40 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:40 INFO - 'TEST1': 'testie', 18:48:40 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:40 INFO - 'USERDOMAIN': 'T-W864-IX-095', 18:48:40 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 18:48:40 INFO - 'USERNAME': 'cltbld', 18:48:40 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-095', 18:48:40 INFO - 'WINDIR': 'C:\\windows', 18:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:41 INFO - Downloading/unpacking psutil>=3.1.1 18:48:41 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 18:48:41 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 18:48:42 INFO - Installing collected packages: psutil 18:48:42 INFO - Successfully installed psutil 18:48:42 INFO - Cleaning up... 18:48:43 INFO - Return code: 0 18:48:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 18:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:43 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02318640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028BE020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E2EC00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C0E90>, '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 0x01D9A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A25C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-095', 'USERDOMAIN': 'T-W864-IX-095', '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-095', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-095', '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;C:\\mozilla-build\\hg', '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-095\\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 18:48:43 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build 18:48:43 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:48:43 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:48:43 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Roaming', 18:48:43 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:48:43 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:48:43 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:48:43 INFO - 'COMPUTERNAME': 'T-W864-IX-095', 18:48:43 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:48:43 INFO - 'DCLOCATION': 'SCL3', 18:48:43 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:48:43 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:48:43 INFO - 'HOMEDRIVE': 'C:', 18:48:43 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 18:48:43 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:48:43 INFO - 'KTS_VERSION': '1.19c', 18:48:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 18:48:43 INFO - 'LOGONSERVER': '\\\\T-W864-IX-095', 18:48:43 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:48:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:43 INFO - 'MOZ_NO_REMOTE': '1', 18:48:43 INFO - 'NO_EM_RESTART': '1', 18:48:43 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:48:43 INFO - 'OS': 'Windows_NT', 18:48:43 INFO - 'OURDRIVE': 'C:', 18:48:43 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;C:\\mozilla-build\\hg', 18:48:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:48:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:48:43 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:48:43 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:48:43 INFO - 'PROCESSOR_LEVEL': '6', 18:48:43 INFO - 'PROCESSOR_REVISION': '1e05', 18:48:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:48:43 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:48:43 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:48:43 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:48:43 INFO - 'PROMPT': '$P$G', 18:48:43 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 18:48:43 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:48:43 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:48:43 INFO - 'PWD': 'C:\\slave\\test', 18:48:43 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:48:43 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:48:43 INFO - 'SYSTEMDRIVE': 'C:', 18:48:43 INFO - 'SYSTEMROOT': 'C:\\windows', 18:48:43 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:43 INFO - 'TEST1': 'testie', 18:48:43 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:43 INFO - 'USERDOMAIN': 'T-W864-IX-095', 18:48:43 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 18:48:43 INFO - 'USERNAME': 'cltbld', 18:48:43 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-095', 18:48:43 INFO - 'WINDIR': 'C:\\windows', 18:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:48:43 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 18:48:43 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 18:48:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:48:44 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 18:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.3) 18:48:44 INFO - Installing collected packages: mozsystemmonitor 18:48:44 INFO - Running setup.py install for mozsystemmonitor 18:48:44 INFO - Successfully installed mozsystemmonitor 18:48:44 INFO - Cleaning up... 18:48:45 INFO - Return code: 0 18:48:45 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 18:48:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:45 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02318640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028BE020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E2EC00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C0E90>, '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 0x01D9A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A25C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-095', 'USERDOMAIN': 'T-W864-IX-095', '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-095', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-095', '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;C:\\mozilla-build\\hg', '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-095\\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 18:48:45 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build 18:48:45 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:48:45 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:48:45 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Roaming', 18:48:45 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:48:45 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:48:45 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:48:45 INFO - 'COMPUTERNAME': 'T-W864-IX-095', 18:48:45 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:48:45 INFO - 'DCLOCATION': 'SCL3', 18:48:45 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:48:45 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:48:45 INFO - 'HOMEDRIVE': 'C:', 18:48:45 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 18:48:45 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:48:45 INFO - 'KTS_VERSION': '1.19c', 18:48:45 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 18:48:45 INFO - 'LOGONSERVER': '\\\\T-W864-IX-095', 18:48:45 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:48:45 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:45 INFO - 'MOZ_NO_REMOTE': '1', 18:48:45 INFO - 'NO_EM_RESTART': '1', 18:48:45 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:48:45 INFO - 'OS': 'Windows_NT', 18:48:45 INFO - 'OURDRIVE': 'C:', 18:48:45 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;C:\\mozilla-build\\hg', 18:48:45 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:48:45 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:48:45 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:48:45 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:48:45 INFO - 'PROCESSOR_LEVEL': '6', 18:48:45 INFO - 'PROCESSOR_REVISION': '1e05', 18:48:45 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:48:45 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:48:45 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:48:45 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:48:45 INFO - 'PROMPT': '$P$G', 18:48:45 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 18:48:45 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:48:45 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:48:45 INFO - 'PWD': 'C:\\slave\\test', 18:48:45 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:48:45 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:48:45 INFO - 'SYSTEMDRIVE': 'C:', 18:48:45 INFO - 'SYSTEMROOT': 'C:\\windows', 18:48:45 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:45 INFO - 'TEST1': 'testie', 18:48:45 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:45 INFO - 'USERDOMAIN': 'T-W864-IX-095', 18:48:45 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 18:48:45 INFO - 'USERNAME': 'cltbld', 18:48:45 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-095', 18:48:45 INFO - 'WINDIR': 'C:\\windows', 18:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:45 INFO - Downloading/unpacking jsonschema==2.5.1 18:48:45 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 18:48:45 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 18:48:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:48:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:48:46 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 18:48:46 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 18:48:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:48:46 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 18:48:46 INFO - warning: no files found matching '*.txt' 18:48:46 INFO - no previously-included directories found matching 'build' 18:48:46 INFO - no previously-included directories found matching 'dist' 18:48:46 INFO - no previously-included directories found matching '.git*' 18:48:46 INFO - Installing collected packages: jsonschema, functools32 18:48:46 INFO - Running setup.py install for functools32 18:48:46 INFO - warning: no files found matching '*.txt' 18:48:46 INFO - no previously-included directories found matching 'build' 18:48:46 INFO - no previously-included directories found matching 'dist' 18:48:46 INFO - no previously-included directories found matching '.git*' 18:48:46 INFO - Successfully installed jsonschema functools32 18:48:46 INFO - Cleaning up... 18:48:47 INFO - Return code: 0 18:48:47 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 18:48:47 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:47 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:47 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02318640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028BE020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E2EC00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C0E90>, '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 0x01D9A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A25C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-095', 'USERDOMAIN': 'T-W864-IX-095', '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-095', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-095', '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;C:\\mozilla-build\\hg', '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-095\\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 18:48:47 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 18:48:47 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:48:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:48:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Roaming', 18:48:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:48:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:48:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:48:47 INFO - 'COMPUTERNAME': 'T-W864-IX-095', 18:48:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:48:47 INFO - 'DCLOCATION': 'SCL3', 18:48:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:48:47 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:48:47 INFO - 'HOMEDRIVE': 'C:', 18:48:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 18:48:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:48:47 INFO - 'KTS_VERSION': '1.19c', 18:48:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 18:48:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-095', 18:48:47 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:48:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:47 INFO - 'MOZ_NO_REMOTE': '1', 18:48:47 INFO - 'NO_EM_RESTART': '1', 18:48:47 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:48:47 INFO - 'OS': 'Windows_NT', 18:48:47 INFO - 'OURDRIVE': 'C:', 18:48:47 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;C:\\mozilla-build\\hg', 18:48:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:48:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:48:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:48:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:48:47 INFO - 'PROCESSOR_LEVEL': '6', 18:48:47 INFO - 'PROCESSOR_REVISION': '1e05', 18:48:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:48:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:48:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:48:47 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:48:47 INFO - 'PROMPT': '$P$G', 18:48:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 18:48:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:48:47 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:48:47 INFO - 'PWD': 'C:\\slave\\test', 18:48:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:48:47 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:48:47 INFO - 'SYSTEMDRIVE': 'C:', 18:48:47 INFO - 'SYSTEMROOT': 'C:\\windows', 18:48:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:47 INFO - 'TEST1': 'testie', 18:48:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:47 INFO - 'USERDOMAIN': 'T-W864-IX-095', 18:48:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 18:48:47 INFO - 'USERNAME': 'cltbld', 18:48:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-095', 18:48:47 INFO - 'WINDIR': 'C:\\windows', 18:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 18:48:47 INFO - Cleaning up... 18:48:47 INFO - Return code: 0 18:48:47 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 18:48:47 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:47 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:47 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 0x02318640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028BE020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E2EC00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C0E90>, '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 0x01D9A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A25C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-095', 'USERDOMAIN': 'T-W864-IX-095', '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-095', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-095', '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;C:\\mozilla-build\\hg', '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-095\\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 18:48:47 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 18:48:47 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --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 18:48:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:48:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Roaming', 18:48:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:48:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:48:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:48:47 INFO - 'COMPUTERNAME': 'T-W864-IX-095', 18:48:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:48:47 INFO - 'DCLOCATION': 'SCL3', 18:48:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:48:47 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:48:47 INFO - 'HOMEDRIVE': 'C:', 18:48:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 18:48:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:48:47 INFO - 'KTS_VERSION': '1.19c', 18:48:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 18:48:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-095', 18:48:47 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:48:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:47 INFO - 'MOZ_NO_REMOTE': '1', 18:48:47 INFO - 'NO_EM_RESTART': '1', 18:48:47 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:48:47 INFO - 'OS': 'Windows_NT', 18:48:47 INFO - 'OURDRIVE': 'C:', 18:48:47 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;C:\\mozilla-build\\hg', 18:48:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:48:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:48:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:48:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:48:47 INFO - 'PROCESSOR_LEVEL': '6', 18:48:47 INFO - 'PROCESSOR_REVISION': '1e05', 18:48:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:48:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:48:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:48:47 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:48:47 INFO - 'PROMPT': '$P$G', 18:48:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 18:48:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:48:47 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:48:47 INFO - 'PWD': 'C:\\slave\\test', 18:48:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:48:47 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:48:47 INFO - 'SYSTEMDRIVE': 'C:', 18:48:47 INFO - 'SYSTEMROOT': 'C:\\windows', 18:48:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:47 INFO - 'TEST1': 'testie', 18:48:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:47 INFO - 'USERDOMAIN': 'T-W864-IX-095', 18:48:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 18:48:47 INFO - 'USERNAME': 'cltbld', 18:48:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-095', 18:48:47 INFO - 'WINDIR': 'C:\\windows', 18:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:48 INFO - Downloading/unpacking blobuploader==1.2.4 18:48:48 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 18:48:48 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 18:48:49 INFO - Downloading blobuploader-1.2.4.tar.gz 18:48:49 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 18:48:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:48:49 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 18:48:49 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 18:48:49 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 18:48:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:48:49 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 18:48:49 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 18:48:49 INFO - Downloading docopt-0.6.1.tar.gz 18:48:49 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 18:48:49 INFO - Installing collected packages: blobuploader, requests, docopt 18:48:49 INFO - Running setup.py install for blobuploader 18:48:49 INFO - Running setup.py install for requests 18:48:50 INFO - Running setup.py install for docopt 18:48:50 INFO - Successfully installed blobuploader requests docopt 18:48:50 INFO - Cleaning up... 18:48:51 INFO - Return code: 0 18:48:51 INFO - Installing None into virtualenv C:\slave\test\build/venv 18:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:51 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--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 0x02318640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028BE020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E2EC00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C0E90>, '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 0x01D9A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A25C0>, '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-095', 'USERDOMAIN': 'T-W864-IX-095', '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-095', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-095', '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;C:\\mozilla-build\\hg', '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-095\\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 18:48:51 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--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 18:48:51 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --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 18:48:51 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:48:51 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Roaming', 18:48:51 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:48:51 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:48:51 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:48:51 INFO - 'COMPUTERNAME': 'T-W864-IX-095', 18:48:51 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:48:51 INFO - 'DCLOCATION': 'SCL3', 18:48:51 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:48:51 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:48:51 INFO - 'HOMEDRIVE': 'C:', 18:48:51 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 18:48:51 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:48:51 INFO - 'KTS_VERSION': '1.19c', 18:48:51 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 18:48:51 INFO - 'LOGONSERVER': '\\\\T-W864-IX-095', 18:48:51 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:48:51 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:51 INFO - 'MOZ_NO_REMOTE': '1', 18:48:51 INFO - 'NO_EM_RESTART': '1', 18:48:51 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:48:51 INFO - 'OS': 'Windows_NT', 18:48:51 INFO - 'OURDRIVE': 'C:', 18:48:51 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;C:\\mozilla-build\\hg', 18:48:51 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:48:51 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:48:51 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:48:51 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:48:51 INFO - 'PROCESSOR_LEVEL': '6', 18:48:51 INFO - 'PROCESSOR_REVISION': '1e05', 18:48:51 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:48:51 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:48:51 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:48:51 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:48:51 INFO - 'PROMPT': '$P$G', 18:48:51 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 18:48:51 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:48:51 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:48:51 INFO - 'PWD': 'C:\\slave\\test', 18:48:51 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:48:51 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:48:51 INFO - 'SYSTEMDRIVE': 'C:', 18:48:51 INFO - 'SYSTEMROOT': 'C:\\windows', 18:48:51 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:51 INFO - 'TEST1': 'testie', 18:48:51 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:48:51 INFO - 'USERDOMAIN': 'T-W864-IX-095', 18:48:51 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 18:48:51 INFO - 'USERNAME': 'cltbld', 18:48:51 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-095', 18:48:51 INFO - 'WINDIR': 'C:\\windows', 18:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 18:48:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lb35pv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 18:48:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 18:48:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-exl23t-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 18:48:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 18:48:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-p1m3cs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 18:48:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 18:48:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kid9zs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 18:48:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 18:48:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yidxtu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 18:48:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 18:48:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cxb0md-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 18:48:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 18:48:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dco3b4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 18:48:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 18:48:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xgy8vs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 18:48:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 18:48:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-swzatf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 18:48:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 18:48:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ppewgy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 18:48:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 18:48:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_lx8ir-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 18:48:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 18:48:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-btdszf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 18:48:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 18:48:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3iusdh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 18:48:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 18:48:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kksi6w-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 18:48:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 18:48:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uzwpw0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 18:48:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 18:48:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ws27_j-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 18:48:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 18:48:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mz2q5r-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 18:48:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:48:54 INFO - Running setup.py install for manifestparser 18:48:54 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 18:48:54 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 18:48:54 INFO - Running setup.py install for mozcrash 18:48:55 INFO - Running setup.py install for mozdebug 18:48:55 INFO - Running setup.py install for mozdevice 18:48:55 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 18:48:55 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 18:48:55 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 18:48:55 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 18:48:55 INFO - Running setup.py install for mozfile 18:48:56 INFO - Running setup.py install for mozhttpd 18:48:56 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 18:48:56 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 18:48:56 INFO - Running setup.py install for mozinfo 18:48:57 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 18:48:57 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 18:48:57 INFO - Running setup.py install for mozInstall 18:48:57 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 18:48:57 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 18:48:57 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 18:48:57 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 18:48:57 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 18:48:57 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 18:48:57 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 18:48:57 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 18:48:57 INFO - Running setup.py install for mozleak 18:48:58 INFO - Running setup.py install for mozlog 18:48:58 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 18:48:58 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 18:48:58 INFO - Running setup.py install for moznetwork 18:48:59 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 18:48:59 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 18:48:59 INFO - Running setup.py install for mozprocess 18:48:59 INFO - Running setup.py install for mozprofile 18:49:00 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 18:49:00 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 18:49:00 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 18:49:00 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 18:49:00 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 18:49:00 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 18:49:00 INFO - Running setup.py install for mozrunner 18:49:00 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 18:49:00 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 18:49:01 INFO - Running setup.py install for mozscreenshot 18:49:01 INFO - Running setup.py install for moztest 18:49:02 INFO - Running setup.py install for mozversion 18:49:02 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 18:49:02 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 18:49:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:49:02 INFO - Cleaning up... 18:49:02 INFO - Return code: 0 18:49:02 INFO - Installing None into virtualenv C:\slave\test\build/venv 18:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:02 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 0x02318640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028BE020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E2EC00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C0E90>, '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 0x01D9A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A25C0>, '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-095', 'USERDOMAIN': 'T-W864-IX-095', '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-095', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-095', '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;C:\\mozilla-build\\hg', '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-095\\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 18:49:02 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 18:49:02 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --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 18:49:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:49:02 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Roaming', 18:49:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:49:02 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:49:02 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:49:02 INFO - 'COMPUTERNAME': 'T-W864-IX-095', 18:49:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:49:02 INFO - 'DCLOCATION': 'SCL3', 18:49:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:49:02 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:49:02 INFO - 'HOMEDRIVE': 'C:', 18:49:02 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 18:49:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:49:02 INFO - 'KTS_VERSION': '1.19c', 18:49:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 18:49:02 INFO - 'LOGONSERVER': '\\\\T-W864-IX-095', 18:49:02 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:49:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:02 INFO - 'MOZ_NO_REMOTE': '1', 18:49:02 INFO - 'NO_EM_RESTART': '1', 18:49:02 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:49:02 INFO - 'OS': 'Windows_NT', 18:49:02 INFO - 'OURDRIVE': 'C:', 18:49: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;C:\\mozilla-build\\hg', 18:49:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:49:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:49:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:49:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:49:02 INFO - 'PROCESSOR_LEVEL': '6', 18:49:02 INFO - 'PROCESSOR_REVISION': '1e05', 18:49:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:49:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:49:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:49:02 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:49:02 INFO - 'PROMPT': '$P$G', 18:49:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 18:49:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:49:02 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:49:02 INFO - 'PWD': 'C:\\slave\\test', 18:49:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:49:02 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:49:02 INFO - 'SYSTEMDRIVE': 'C:', 18:49:02 INFO - 'SYSTEMROOT': 'C:\\windows', 18:49:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:49:02 INFO - 'TEST1': 'testie', 18:49:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:49:02 INFO - 'USERDOMAIN': 'T-W864-IX-095', 18:49:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 18:49:02 INFO - 'USERNAME': 'cltbld', 18:49:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-095', 18:49:02 INFO - 'WINDIR': 'C:\\windows', 18:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 18:49:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nfhox_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 18:49:02 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)) 18:49:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 18:49:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mnivft-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 18:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 18:49:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 18:49:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jvqecv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 18:49:03 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)) 18:49:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 18:49:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-08mce5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 18:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 18:49:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 18:49:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rx_lcg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 18:49:03 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)) 18:49:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 18:49:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xd7sts-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 18:49:03 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)) 18:49:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 18:49:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ueopcu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 18:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 18:49:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 18:49:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ekvlyh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 18:49:03 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)) 18:49:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 18:49:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3uwx0g-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 18:49:03 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)) 18:49:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 18:49:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gtangi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 18:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 18:49:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 18:49:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cpmbzh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 18:49:04 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)) 18:49:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 18:49:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vr6ybp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 18:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 18:49:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 18:49:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bq0chb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 18:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 18:49:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 18:49:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ujzsun-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 18:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 18:49:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 18:49:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6qpepf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 18:49:04 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)) 18:49:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 18:49:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-un21lp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 18:49:04 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)) 18:49:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 18:49:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jwjx27-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 18:49:04 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)) 18:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 18:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 18:49:04 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)) 18:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.49->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 18:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.49->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 18:49:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 18:49: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 18:49: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 18:49:05 INFO - Downloading blessings-1.6.tar.gz 18:49:05 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 18:49:06 INFO - Installing collected packages: blessings 18:49:06 INFO - Running setup.py install for blessings 18:49:06 INFO - Successfully installed blessings 18:49:06 INFO - Cleaning up... 18:49:09 INFO - Return code: 0 18:49:09 INFO - Done creating virtualenv C:\slave\test\build/venv. 18:49:09 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 18:49:09 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 18:49:09 INFO - Reading from file tmpfile_stdout 18:49:09 INFO - Using _rmtree_windows ... 18:49:09 INFO - Using _rmtree_windows ... 18:49:09 INFO - Current package versions: 18:49:09 INFO - blessings == 1.6 18:49:09 INFO - blobuploader == 1.2.4 18:49:09 INFO - docopt == 0.6.1 18:49:09 INFO - functools32 == 3.2.3-2 18:49:09 INFO - jsonschema == 2.5.1 18:49:09 INFO - manifestparser == 1.1 18:49:09 INFO - mozInstall == 1.12 18:49:09 INFO - mozcrash == 1.0 18:49:09 INFO - mozdebug == 0.1 18:49:09 INFO - mozdevice == 0.49 18:49:09 INFO - mozfile == 1.2 18:49:09 INFO - mozhttpd == 0.7 18:49:09 INFO - mozinfo == 0.9 18:49:09 INFO - mozleak == 0.1 18:49:09 INFO - mozlog == 3.4 18:49:09 INFO - moznetwork == 0.27 18:49:09 INFO - mozprocess == 0.23 18:49:09 INFO - mozprofile == 0.28 18:49:09 INFO - mozrunner == 6.13 18:49:09 INFO - mozscreenshot == 0.1 18:49:09 INFO - mozsystemmonitor == 0.3 18:49:09 INFO - moztest == 0.7 18:49:09 INFO - mozversion == 1.4 18:49:09 INFO - psutil == 3.1.1 18:49:09 INFO - requests == 1.2.3 18:49:09 INFO - Installing None into virtualenv C:\slave\test\build/venv 18:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:09 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 0x02318640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028BE020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E2EC00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C0E90>, '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 0x01D9A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A25C0>, '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-095', 'USERDOMAIN': 'T-W864-IX-095', '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-095', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-095', '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;C:\\mozilla-build\\hg', '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-095\\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 18:49:09 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--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 18:49:09 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --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 18:49:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:49:09 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Roaming', 18:49:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:49:09 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:49:09 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:49:09 INFO - 'COMPUTERNAME': 'T-W864-IX-095', 18:49:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:49:09 INFO - 'DCLOCATION': 'SCL3', 18:49:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:49:09 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:49:09 INFO - 'HOMEDRIVE': 'C:', 18:49:09 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 18:49:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:49:09 INFO - 'KTS_VERSION': '1.19c', 18:49:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 18:49:09 INFO - 'LOGONSERVER': '\\\\T-W864-IX-095', 18:49:09 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:49:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:09 INFO - 'MOZ_NO_REMOTE': '1', 18:49:09 INFO - 'NO_EM_RESTART': '1', 18:49:09 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:49:09 INFO - 'OS': 'Windows_NT', 18:49:09 INFO - 'OURDRIVE': 'C:', 18:49:09 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;C:\\mozilla-build\\hg', 18:49:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:49:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:49:09 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:49:09 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:49:09 INFO - 'PROCESSOR_LEVEL': '6', 18:49:09 INFO - 'PROCESSOR_REVISION': '1e05', 18:49:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:49:09 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:49:09 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:49:09 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:49:09 INFO - 'PROMPT': '$P$G', 18:49:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 18:49:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:49:09 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:49:09 INFO - 'PWD': 'C:\\slave\\test', 18:49:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:49:09 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:49:09 INFO - 'SYSTEMDRIVE': 'C:', 18:49:09 INFO - 'SYSTEMROOT': 'C:\\windows', 18:49:09 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:49:09 INFO - 'TEST1': 'testie', 18:49:09 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:49:09 INFO - 'USERDOMAIN': 'T-W864-IX-095', 18:49:09 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 18:49:09 INFO - 'USERNAME': 'cltbld', 18:49:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-095', 18:49:09 INFO - 'WINDIR': 'C:\\windows', 18:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 18:49:09 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 2)) 18:49:09 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 3)) 18:49:09 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 4)) 18:49:09 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 5)) 18:49:09 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 6)) 18:49:09 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 7)) 18:49:09 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 8)) 18:49:09 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 9)) 18:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 18:49:09 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 4)) 18:49:09 INFO - Cleaning up... 18:49:10 INFO - Return code: 0 18:49:10 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 18:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:10 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02318640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028BE020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E2EC00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C0E90>, '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 0x01D9A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A25C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-095', 'USERDOMAIN': 'T-W864-IX-095', '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-095', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-095', '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;C:\\mozilla-build\\hg', '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-095\\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 18:49:10 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 18:49:10 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:49:10 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:49:10 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Roaming', 18:49:10 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:49:10 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:49:10 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:49:10 INFO - 'COMPUTERNAME': 'T-W864-IX-095', 18:49:10 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:49:10 INFO - 'DCLOCATION': 'SCL3', 18:49:10 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:49:10 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:49:10 INFO - 'HOMEDRIVE': 'C:', 18:49:10 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 18:49:10 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:49:10 INFO - 'KTS_VERSION': '1.19c', 18:49:10 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 18:49:10 INFO - 'LOGONSERVER': '\\\\T-W864-IX-095', 18:49:10 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:49:10 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:10 INFO - 'MOZ_NO_REMOTE': '1', 18:49:10 INFO - 'NO_EM_RESTART': '1', 18:49:10 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:49:10 INFO - 'OS': 'Windows_NT', 18:49:10 INFO - 'OURDRIVE': 'C:', 18:49:10 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;C:\\mozilla-build\\hg', 18:49:10 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:49:10 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:49:10 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:49:10 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:49:10 INFO - 'PROCESSOR_LEVEL': '6', 18:49:10 INFO - 'PROCESSOR_REVISION': '1e05', 18:49:10 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:49:10 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:49:10 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:49:10 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:49:10 INFO - 'PROMPT': '$P$G', 18:49:10 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 18:49:10 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:49:10 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:49:10 INFO - 'PWD': 'C:\\slave\\test', 18:49:10 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:49:10 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:49:10 INFO - 'SYSTEMDRIVE': 'C:', 18:49:10 INFO - 'SYSTEMROOT': 'C:\\windows', 18:49:10 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:49:10 INFO - 'TEST1': 'testie', 18:49:10 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:49:10 INFO - 'USERDOMAIN': 'T-W864-IX-095', 18:49:10 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 18:49:10 INFO - 'USERNAME': 'cltbld', 18:49:10 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-095', 18:49:10 INFO - 'WINDIR': 'C:\\windows', 18:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 18:49:10 INFO - Cleaning up... 18:49:10 INFO - Return code: 0 18:49:10 INFO - Running post-action listener: _resource_record_post_action 18:49:10 INFO - Running post-action listener: _start_resource_monitoring 18:49:10 INFO - Starting resource monitoring. 18:49:10 INFO - [mozharness: 2016-11-25 02:49:10.460000Z] Finished create-virtualenv step (success) 18:49:10 INFO - [mozharness: 2016-11-25 02:49:10.460000Z] Running install step. 18:49:10 INFO - Running pre-action listener: _resource_record_pre_action 18:49:10 INFO - Running main action method: install 18:49:10 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 18:49:10 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 18:49:10 INFO - Reading from file tmpfile_stdout 18:49:10 INFO - Using _rmtree_windows ... 18:49:10 INFO - Using _rmtree_windows ... 18:49:10 INFO - Detecting whether we're running mozinstall >=1.0... 18:49:10 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 18:49:10 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 18:49:10 INFO - Reading from file tmpfile_stdout 18:49:10 INFO - Output received: 18:49:10 INFO - Usage: mozinstall-script.py [options] installer 18:49:10 INFO - Options: 18:49:10 INFO - -h, --help show this help message and exit 18:49:10 INFO - -d DEST, --destination=DEST 18:49:10 INFO - Directory to install application into. [default: 18:49:10 INFO - "C:\slave\test"] 18:49:10 INFO - --app=APP Application being installed. [default: firefox] 18:49:10 INFO - Using _rmtree_windows ... 18:49:10 INFO - Using _rmtree_windows ... 18:49:10 INFO - mkdir: C:\slave\test\build\application 18:49:10 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-53.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 18:49:10 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-53.0a1.en-US.win64.zip --destination C:\slave\test\build\application ProcessManager NOT managing child processes 18:49:13 INFO - Reading from file tmpfile_stdout 18:49:13 INFO - Output received: 18:49:13 INFO - C:\slave\test\build\application\firefox\firefox.exe 18:49:13 INFO - Using _rmtree_windows ... 18:49:13 INFO - Using _rmtree_windows ... 18:49:13 INFO - Running post-action listener: _resource_record_post_action 18:49:13 INFO - [mozharness: 2016-11-25 02:49:13.059000Z] Finished install step (success) 18:49:13 INFO - [mozharness: 2016-11-25 02:49:13.059000Z] Running run-tests step. 18:49:13 INFO - Running pre-action listener: _resource_record_pre_action 18:49:13 INFO - Running main action method: run_tests 18:49:13 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 18:49:13 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 18:49:13 INFO - Python 2.7.3 18:49:13 INFO - Return code: 0 18:49:13 INFO - grabbing minidump binary from tooltool 18:49:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:13 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C0E90>, '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 0x01D9A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A25C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 18:49:13 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 18:49:13 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 18:49:13 INFO - Calling ['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'] with output_timeout 600 ProcessManager UNABLE to use job objects to manage child processes 18:49:13 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 18:49:13 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpszvne7 18:49:13 INFO - INFO - File integrity verified, renaming tmpszvne7 to win32-minidump_stackwalk.exe 18:49:13 INFO - Return code: 0 18:49:13 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 18:49:13 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 18:49:13 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 18:49:13 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 18:49:13 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 18:49:13 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-095', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] in C:\slave\test\build 18:49:13 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Graphics --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-095 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log 18:49:13 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:49:13 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Roaming', 18:49:13 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:49:13 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:49:13 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:49:13 INFO - 'COMPUTERNAME': 'T-W864-IX-095', 18:49:13 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:49:13 INFO - 'DCLOCATION': 'SCL3', 18:49:13 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:49:13 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:49:13 INFO - 'HOMEDRIVE': 'C:', 18:49:13 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-095', 18:49:13 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:49:13 INFO - 'KTS_VERSION': '1.19c', 18:49:13 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-095\\AppData\\Local', 18:49:13 INFO - 'LOGONSERVER': '\\\\T-W864-IX-095', 18:49:13 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 18:49:13 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 18:49:13 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:49:13 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:13 INFO - 'MOZ_NO_REMOTE': '1', 18:49:13 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 18:49:13 INFO - 'NO_EM_RESTART': '1', 18:49:13 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:49:13 INFO - 'OS': 'Windows_NT', 18:49:13 INFO - 'OURDRIVE': 'C:', 18:49:13 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;C:\\mozilla-build\\hg', 18:49:13 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:49:13 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:49:13 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:49:13 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:49:13 INFO - 'PROCESSOR_LEVEL': '6', 18:49:13 INFO - 'PROCESSOR_REVISION': '1e05', 18:49:13 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:49:13 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:49:13 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:49:13 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:49:13 INFO - 'PROMPT': '$P$G', 18:49:13 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 18:49:13 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:49:13 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:49:13 INFO - 'PWD': 'C:\\slave\\test', 18:49:13 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 18:49:13 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:49:13 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:49:13 INFO - 'SYSTEMDRIVE': 'C:', 18:49:13 INFO - 'SYSTEMROOT': 'C:\\windows', 18:49:13 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:49:13 INFO - 'TEST1': 'testie', 18:49:13 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:49:13 INFO - 'USERDOMAIN': 'T-W864-IX-095', 18:49:13 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-095', 18:49:13 INFO - 'USERNAME': 'cltbld', 18:49:13 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-095', 18:49:13 INFO - 'WINDIR': 'C:\\windows', 18:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:49:13 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-095', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 18:49:14 INFO - mozversion application_buildid: 20161124171918 18:49:14 INFO - mozversion application_changeset: 2f27eb71f5234f424c0e12a73df2ed89410cc12e 18:49:14 INFO - mozversion application_display_name: Nightly 18:49:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:49:14 INFO - mozversion application_name: Firefox 18:49:14 INFO - mozversion application_remotingname: firefox 18:49:14 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 18:49:14 INFO - mozversion application_vendor: Mozilla 18:49:14 INFO - mozversion application_version: 53.0a1 18:49:14 INFO - mozversion platform_buildid: 20161124171918 18:49:14 INFO - mozversion platform_changeset: 2f27eb71f5234f424c0e12a73df2ed89410cc12e 18:49:14 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 18:49:14 INFO - mozversion platform_version: 53.0a1 18:49:14 INFO - using testdate: 1480042154 18:49:14 INFO - actual date: 1480042154 18:49:14 INFO - starting webserver on 'localhost:49291' 18:49:14 INFO - SUITE-START | Running 2 tests 18:49:14 INFO - TEST-START | dromaeo_css 18:49:14 INFO - operating with platform_type : w8_ 18:49:14 INFO - Initialising browser for dromaeo_css test... 18:49:14 INFO - TEST-INFO | started process 3452 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp27jipr\profile http://localhost:49291/getInfo.html) 18:49:21 INFO - PROCESS | 3452 | __metrics Screen width/height:1600/1200 18:49:21 INFO - PROCESS | 3452 | colorDepth:24 18:49:21 INFO - PROCESS | 3452 | Browser inner width/height: 1010/674 18:49:21 INFO - PROCESS | 3452 | __metrics 18:49:23 INFO - PROCESS | 3452 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:49:23 INFO - PROCESS | 3452 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:49:24 INFO - TEST-INFO | 3452: exit 0 18:49:24 INFO - Browser initialized. 18:49:24 INFO - Running cycle 1/1 for dromaeo_css test... 18:49:24 INFO - TEST-INFO | started process 2548 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp27jipr\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:25 INFO - PROCESS | 2548 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 18:49:36 INFO - PROCESS | 2548 | RSS: Main: 175611904 18:49:36 INFO - PROCESS | 2548 | 18:50:27 INFO - PROCESS | 2548 | 1480042227818 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] 18:52:38 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49291/tests/dromaeo/cssquery-ext.html) 18:52:39 INFO - PROCESS | 2548 | RSS: Main: 221134848 18:52:39 INFO - PROCESS | 2548 | 18:55:42 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-ext.html (next: http://localhost:49291/tests/dromaeo/cssquery-jquery.html) 18:55:43 INFO - PROCESS | 2548 | RSS: Main: 236564480 18:55:43 INFO - PROCESS | 2548 | 18:58:45 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49291/tests/dromaeo/cssquery-mootools.html) 18:58:46 INFO - PROCESS | 2548 | RSS: Main: 187580416 18:58:46 INFO - PROCESS | 2548 | 19:01:48 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49291/tests/dromaeo/cssquery-prototype.html) 19:01:49 INFO - PROCESS | 2548 | RSS: Main: 185765888 19:01:49 INFO - PROCESS | 2548 | 19:04:52 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49291/tests/dromaeo/cssquery-yui.html) 19:04:53 INFO - PROCESS | 2548 | RSS: Main: 170450944 19:04:53 INFO - PROCESS | 2548 | 19:07:56 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-yui.html (next: http://localhost:49291/tests/dromaeo/cssquery-dojo.html) 19:07:56 INFO - PROCESS | 2548 | RSS: Main: 215580672 19:07:56 INFO - PROCESS | 2548 | 19:07:56 INFO - PROCESS | 2548 | __start_tp_report 19:07:56 INFO - PROCESS | 2548 | _x_x_mozilla_page_load 19:07:56 INFO - PROCESS | 2548 | _x_x_mozilla_page_load_details 19:07:56 INFO - PROCESS | 2548 | |i|pagename|runs| 19:07:56 INFO - PROCESS | 2548 | |0;dojo.html;2596;2601.284646722151;2611.0730690604823;2633.868306584671;2650.456656385441;4347.239233134201;4353.107612939348;4353.825846966125;4369.606735393818;4383.890402739933;4088.8364465421346;4152.314868046777;4342.131573685259;4387.758673272969;4407.911841763171;3841.19334939663;3958.9802050989706;3983.4224037514687;3997.880063598082;4062.614051665087;3953.604639536052;3979.7413168143976;4018.537868145157;4033.7781422021776;4065.7763822989723;3988.78061706606;4014.3978403239603;4038.4749982502235;4047.4131250968594;4067.7559346439307;3790.4124860646643;3828.5022947016987;3932.3708206686792;3990.9201815963806;4042.535108462535;3943.1719338938856;3944.5463771666336;3950.4666869972475;3957.5053118360206;3982.681385489154;4150.439690641755;4299.097189590189;4308.073764140693;4308.267594508941;4334.1981733379425;4411.779411029468;4443.333499974998;4460.107978404332;4484.798184081724;4486.708363956365;4503.729776213405;4509.278515437547;4512.12013657337;4527.049319642879;4540.7502587357685;4214.91570168598;4222.9788851055855;4227.661787057028;4262.65898728101;4266.168097221043;4427.933580996288;4504.572065653758;4507.684462087688;4581.518940511265;4669.883252918637;4474.574915383034;4530.909381812346;4551.704139230939;4558.316252562142;4564.178447879413;4579.38178345919;4583.610393116555;4592.081583683277;4593.26507758757;4638.0491999140095;4303.8708838734265;4391.626711729475;4394.2969124939855;4499.392582001454;4531;4409.250427427345;4413.337999300066;4436.556344365602;4446.066326071561;4447.3329000650165;3101.7673674474504;3105.4254962831947;3106.176863131272;3134.18511187093;3136.4354416204847;2905.7940954503642;2927.6925922778228;2950.616419865447;2960.8223506589675;2966.4215477982016;4278.358246263086;4291.141771645684;4294.613484786384;4304.698671093056;4347.891302717394;4376.540463251376;4403.493598236179;4433.667474939328;4600.240960241589;4660.86017419478;4199.76901270427;4276.2089013532595;4277.871663850089;4288;4304.504981927118;3805.7145714071557;3830.7701537907255;3841.1741475582885;3846.576876543578;3877.41838724188;4417.690761646782;4544.659150563721;4620.468646105741;4626.74552899587;4659.068186362673;4377.606015458624;4513.661475389425;4588.977055114703;4627.5603817637275;4639.721616703008;4656.487786343432;4699.177643912233;4704;4711.104890070876;4751.548602882721;4554.749488778149;4577.702449340783;4577.977110114562;4579.862604121881;4613.5847773700525;4369.628581570602;4412.955870441255;4558.9772051139535;4602.976985115053;4653.348531205702;4519.887002824956;4534.115847409724;4560.3843481129625;4579.427571553556;4581.266997280419;4506.887327816831;4525.981654127795;4534.88662783433;4550.7497087660495;4582.770861456847;4279.122779830065;4365.607095361433;4382.474103107647;4454.5990860822685;4479.372887795646;4489.304157855538;4510.954890451054;4523.140603285366;4524.524924882971;4530.546945305443;4445.711028783118;4450.399196108613;4452.465704115527;4483.14820184164;4491.820327186876 19:07:56 INFO - PROCESS | 2548 | |1;ext.html;552.3620218647462;554.7891801115577;571.974261158248;596.1058412381428;598.9221401217847;34161.82919085404;36403.45394819076;36484.63515364846;39396.21207575847;39436.40845387321;36642.63357366426;36740.26519469609;37040.444393334124;37080.62919370805;37084.258314833685;7020.946857971319;7261.092363454568;7694.115176754661;7834.843303133934;7840.529568225897;9368.484733339663;9600.423974561549;9656.324057315991;9669.274804389664;9693.709188724315;9356.438613683167;9371.20344770692;9399.248060155205;9435.528223588828;9439.292053096011;9290.349675522717;9303.58133883977;9366.391184572982;9371.953140234324;9397.342186046979;9252.8612070819;9261.583228754722;9320.44077355354;9323.25413966881;9330.906690933072;33767.324653507036;33910.49134262988;34201.144971375914;34216;34276;2934.970650293491;3036.711512406318;3069.6469905960876;3108.6114235720534;3117.6258848938046;25447.872760636263;25497.61753573698;25607.359816004562;25664.486710265875;25917;3304.2895777407734;3318.303156337172;3332.6500717424806;3339.5992480902446;3433.725301975836;183672;211082;211484.94257528769;212366;212404.99999999846;46186.307205391946;46558.068838623716;46601;46606.76696616495;46656.300155497695;49028.26457603139;49160.26259606037;49291.753541232065;49394.50605493971;49481;12919.870801291867;13298.867011329956;13300.068995170244;13306.334683265797;13478.393472293574;7377.704891804267;7514.0607424071995;9759.072888075621;9856.31005829585;10269.589216431408;15396.538103856903;15409.383624655113;15418.306176221873;15457.690846183013;15641.843581564266;5562.833115006556;5577.633479797394;5594.664320140723;5597.692126933058;5619.241402410622;838.3586556284447;858.2490320969152;889.7775556110972;929.2751653710117;977.3451787302382;26064.73935260661;26273.474530509666;26425.471490570082;26610.334741631614;26776.732232677812;928.767808047988;951.1392190068;958.1376760915093;966.8791401074866;1011.7268337548968;14017.439302427993;14044.297785110704;14068.718625627635;14204.218767967861;14218.502352417616;122551;292224;292700;293738;294002;47494.5250547497;47549.76225118852;47598.28602570964;47643.285350719765;47675.761621191676;1074.3285446595878;1085.0776839686362;1163.66253786401;1195.7967145585271;1211.309553554483;24260.757392426556;26927.86536067307;27102.322441939108;27210.863945680147;27379.863100684368;40046.799766000986;40050.59949400469;40536.79731601441;40563.391549126194;40596.18807623772;233104;234501;235607;236469;236857;23187.6521852169;23914.402139945945;23966.161184358465;33500.83249583736;33819.830900845336;38791.41812872753;39130.2173956525;39201.6079839198;39252.803735981135;39457;32649.673503265614;33167.83416082904;33202.50196247106;33273;33737.325253495284;32757.181070473427;32982.835085824416;33091.33817323592;33199.83400082984;33542;33314.16714582155;33435.33129337351;33504.49743253902;33659.49510757292;34741.82629086838;29400.852995734884;30183.396332072796;30308.696913030588;30449.23876903095;30663;22269.888650556644;22594;22763.317100487013;23001.769982299964;23066.53866922686 19:07:56 INFO - PROCESS | 2548 | |2;jquery.html;305.1212507977026;324.8656327925529;326.2642740619902;329.6802101961098;336.96124945631243;11766;14731.189784561844;15043.398264069425;15398.384064637416;15870.920645396756;14678.11931284121;14711.264436778145;14749.26253687314;14851.702965940674;14977.700445991073;4629.837955671544;4635.420572428447;4805.855824325258;4806.3030860525205;4843.8062477501035;4655.953440465586;4785.162596545608;4789.521047895218;4791.544803243703;4793.688410253322;4743.881402964919;4749.978754567767;4750.596199323045;4750.76246187691;4758.072175925696;4529.116822219652;4632.119897219518;4635.165670179366;4653.86038418848;4662.463816661094;4121.155163191538;4121.423000779893;4128.215639028605;4128.772917489537;4132.73137246078;17455.86536875099;17674.204660790296;17780.3776867809;17783.46649600514;17856.732149017775;1932.7487426634589;1962.2053068507278;2226.3877433705698;2260.333201705501;2374.8812559372136;11097.33415995043;11773.350261418902;11779.116566257566;12027.759444811054;12167.391630418444;1618.368836153901;1625.9430919917863;1677.5638334033117;1707.4450803488917;1740;49503.50496495061;54140.563674634344;56119.15821262684;57579.13631295576;57897.71051144759;7924.683012679428;8201.95899020501;8241.546714930737;8943.731688049369;9044.276457883354;9221.53892305382;9725.56234969428;11098.334099954029;11791.705207369885;11814;6062.393760623991;6373.884570200196;6439.130717353191;6487.448566871774;6513.837154071091;6069.514438844882;6101.786437474667;6189.876202475925;6193.783217587363;6202.627842329474;3891.6108389161423;3900.6294402031763;3903.765774053509;3960.148568057881;3967.543732470745;1672.916354182286;1706.3430579227088;1716.828317168273;1724.3706047292649;1747.6679430908086;800.3197282310106;811.983760324802;853.4196746212635;869.2394155114275;914.4239129348601;14786.630334241514;15028.323725432163;15035.398584056515;15144.621384465476;15433;875.8861348024716;878.9604467798964;882.250087425683;898.5821592959305;917.4403613795579;7831.765047048598;8574.185452382013;8574.614142363609;8879.689210877717;8991.505467199237;278465;279214;279803;280407;281973;61794.38205617886;63878.68060659667;64023.67988160122;64203.67898160479;64304.67847660826;855.6876739989859;882.849915514364;883.4919921045424;884.5798245833178;884.7920738626418;11067.667969960914;13665.18008919468;13780.586582402544;13845.653858653212;14150.292485375896;29924.401511970074;30238.395232095674;30393.544096838123;30441;30946.84526577353;41497.79251103846;42974.140517188855;43195.35206971835;43404.565954340054;44054.55945440633;5830.82507524775;6452.516061295328;6537.673116344259;6578.0790689304495;6701.095352127595;7560.886586701094;10108.444035578113;10409.47952602382;10477.1094456972;10559.472026398496;8272;8495.702650407206;8689.348298877483;8727.476351418934;8825.985011723735;7726.266004729542;7762.107357653942;7762.5730584818375;7767.339776119094;8436.607959686828;7719.421043421654;7918.524888506708;8250.803633472993;8465.873011904949;8782.341324400568;6374.74501019954;6432.678366081771;6512.218533775977;6552.57408268461;6601.174853143357;6038.9396106038375;7491.513051651626;8463.111373305714;8681.782955426164;8846.248068913957 19:07:56 INFO - PROCESS | 2548 | |3;mootools.html;1230.8769123087689;1236.7402845402464;1281.7756892543803;1462.3054049326572;1485.7697056956176;5503.477169668885;5892.764289428418;5896.056630939051;5897.823065308037;5902.055671092626;5031.823886163985;5233.293505376773;5233.4243233244315;5309.41596424393;5314.123169677008;1738.5653586603348;1805.431289143922;1808.0688445450603;1823.0975667044765;1824.279409633194;1829.5426143464133;1847.5288801355634;1847.8336949674526;1849.0200193897256;1849.5930895203035;1483.4214656284057;1516.4616561120808;1772.565721398253;1811.8188181181843;1817.4911024912979;1703.667784781968;1764.7970483394445;1766.9293228270853;1771.937982170618;1784.2327799046404;1765.64687062588;1781.6080462298273;1795.8922464652162;1797.604527004057;1798.9550261243444;5711.942880571182;5811.389804070554;5840.269966254218;5847.152162936393;5855.5608329375045;3517.929641407183;3641.9453708194133;3645.3073915955883;3645.54430696163;3646.7082633389264;2295.9782896611014;2346.7066616672914;2349.953000939972;2351.5532048910823;2351.929442116739;719.8051234949958;750.5084169868745;759.5556599389364;769.32299576373;782.6478084861778;7017.824554386181;7089.858202835966;7101.076860008166;7125.608091554911;7136.536125151849;3085.506318988951;3161.462551366273;3224.6614105518584;3232.321212545392;3232.8383580820864;6104.603200791934;6393.041043843367;6464.22429308486;6474.514411419068;6477.546571739933;3658.158623516553;3665.3585622516484;3669.412893936957;3673.3571624965525;3678.411454167374;3417.5044618530173;3420.486926960926;3421.469672200813;3422.709069729051;3423.9144021399165;2788.2471732632075;2825.321922738569;2889.422115576851;2889.6965818588747;2907.2877145099164;909.5679552212779;922.561783152997;934.4159900062461;945.9574319155655;946.3753922411175;695.1623293930801;733.3693023999356;747.4580928826666;762.1197516868026;763.0842988413925;3823.751456155341;3948.506436695413;3964.960350396459;3991.2217117661776;4065.57311482296;342.39908959775437;346.13089317684705;346.9774464659789;350.3798277049608;352.19347693781464;2766.667999839992;2808.3681171736603;2823.545873874956;2836.3334616365137;2859;6540.247871494744;6799.354061364163;6903.033575299462;6904.689288982008;6914.515983881181;6823.829404264933;6849.589024658537;6868.278830722802;6868.862622747517;6870.106886104874;5462.016836969304;5555.583331250173;5558.583106267046;5560.694161821058;5561.860953476195;3873.1479074603544;3882.165334453106;3886.7667939923695;3919.334852300463;3977.065389633376;6215.595986260879;6324.873502530016;6327.11420401135;6329.9050514243245;6347.5239357047485;6409.102725618511;6409.2949775525585;6420.486361091195;6425.614463132227;6427;5028.572571331478;5047.066292735855;5065.670731402447;5104.157813960804;5108.770105345194;5325.573954083587;5490.725463726878;5563.388027317073;5573.470520300565;5581.972090139523;4523.864284071483;5023.924641130313;5051.166557517969;5052.8484145475695;5133.717645529532;4732.455767586772;5013.799448022039;5086.669366491166;5117.974410127926;5225.294585230945;4710.4347478302825;4784.521547845187;4784.952150478451;4797.160496912957;4802.135615589227;3341.2816244506575;3413.8293085345135;3425.0409885232175;3435.519027336225;3440.0539851541025;3471.5660542432197;3487.8430470628373;3516.4549494828343;3527.470879368115;3595.712343012605 19:07:56 INFO - PROCESS | 2548 | |4;prototype.html;255.0245311682813;256.9524637941981;259.6844833527264;260.8265503440212;262.3833990123211;4441.400410944521;4491.034427598066;4498.865034048979;4501.189785838547;4516.616087632547;4366.585174408434;4406.889827754299;4420.270655341865;4424.367501336707;4432.20220360335;3286.2277364819247;3404.7446441516863;3448.327576122657;3449.0687514371107;3462.4113900636826;3367.9831600841962;3477.94783078254;3488.372093023255;3491.790492570441;3507.140750516127;3432.553768010155;3467.098554375855;3473.305338932211;3473.513708080871;3487.0584942065625;3281.5241789940565;3477.356689012528;3483.9825800871085;3484.4250698634696;3484.5470088888283;2851.885924563015;2927.5901373807683;2941.4705353036443;2945.337299107705;3056.881980380022;4302.956970430287;4351.369051487517;4361.520232774392;4404.427424434803;4431.784107946027;3921.470601468822;3941.8029098544957;3943.8816835494695;3944.3886197639413;3945.8421663133727;4530.592246697813;4547.522510136454;4618.284165954283;4636.354094296544;4651.162790697673;3275.623303320101;3279.147421670359;3285.162283617662;3286.5398844161837;3307.7188438982716;4840.983393487337;4852.247901575226;4853.95146048542;4858.497873595102;4871.2206047032305;3354.832258387071;3383.5939687237687;3390.3219356128875;3398.5411969384313;3408.4887266910164;3364.3944090064024;3381.9154521136675;3401.132711158639;3416.8120753358307;3447.7414193935056;3876.6511014008875;3890.9456076979436;3894.902627434337;3897.6480227004754;3898.5126859142606;4602.7008244464005;4638.397008388888;4641.443026836733;4659.6505262105475;4670.976645116821;1121.7027487715761;1134.211722852626;1135.7728454309006;1139.4473680265064;1141.6517962021662;779.6998155709979;796.0845028217597;800.6597196191595;807.9676812927418;813.0771574263254;4269.563001783532;4269.701120921568;4273.807678654468;4279;4305.612494875476;4603.240465323184;4650.302824361862;4699.976500117477;4740.834070807505;4847.878803029953;4440.866773996785;4468.89961717992;4489.820407183742;4494.213512635276;4509.6843220974215;2449.7060352757426;2489.601663733794;2491.389609545673;2494.738052504461;2498.6376975338476;4489.236829738952;4666.440027196758;4671.6262698984;4694.36626055485;4725.5983241424865;4718.693284936468;4731.485924504125;4736.542324103424;4748.881277968009;4781.354517140211;4694.483606803249;4705.811767529329;4709.858704238878;4718.575328220477;4729.65204916604;4545.54542546382;4552.9772351138035;4656.1851675955895;4665.6734028617675;4667.903042785011;4594.402727645384;4595.885102872455;4596.264597664358;4608.216603177535;4609.285560738091;4704.388429504143;4710.858674239778;4732.148213321635;4732.651194409576;4732.716037037789;3051.8321492318137;3250.951235731419;3261;3266.6406695263977;3311.420501412195;4830.468648448738;4836.854894353175;4841.9031619366715;4844.563989240985;4925.753712314298;4722.669413141184;4745.691530050535;4781.497942716104;4782.808687652455;4800.4479484859685;4597.494275629611;4692.765361731831;4769.57073863354;4799.184138696361;4802.615790736802;4632.861014169445;4638.582527572535;4649.372334734903;4656.5110663379855;4656.604188644003;4704.29435584665;4710.646701497333;4715.528447155257;4727.314539391838;4751.812046988253;4300.268954277718;4485.689869717033;4627.259638457831;4696.671233013656;4709.105269998689 19:07:56 INFO - PROCESS | 2548 | |5;yui.html;616.6053725615606;664.1996394344815;695.4401706626164;709.1986055756994;719.8632259870624;11078.889211107886;11660.708482287937;11974;12260.203086799353;12273.263604183756;11769.293842369463;11922;11945;11959.22265052771;11965.222260553059;591.5445107267423;609.6585911889334;717.6340066566063;735.8638651849399;743.0303453992537;688.7279524587785;697.8569393274392;699.9440044796429;726.7202127181021;727.5416487612797;801.0747586537558;803.5098589860181;804.6539987805241;805.4361946637348;805.5488926201346;609.6464050850497;624.1324558863183;795.1809636074852;795.308081968688;797.4378063465243;545.9099248624012;562.1399259133532;568.6133429268097;581.9534437245053;582.1558739827267;10871.402072885989;10919.235653504258;10921.945390273077;10924.672259832218;10933.945330273376;10755.731106722316;10933.313374747431;11026.614068507564;11167.385793781339;11417.885821141765;10060.94969525155;10098.646547370807;10110;10130.645427410005;10194.796104077877;3842.5773164951834;3843.2121415109837;3947.3486874665646;3986.960130398688;3998.9400158997637;40594.59405405938;41501;42412.151756964995;42496.78751606253;42569.36145957813;8793.956030219808;8932.508712020772;8944.3738938275;9037;9186.127317904788;15535.06789592628;15541.844581554265;15599.766003509956;15625.84374156244;15626.296816643278;6124.724387402578;6297.685115744194;6327.082573026977;6360.77737279193;6364.204474440695;3580.391333473264;3627.4740162676794;3694.3165514379925;3703;3731.1231860512758;2218.6117429449782;2491.8131140164196;2593.4942686176014;2607.504574130909;2619.5415802234534;410.2205808962935;416.86660268714326;417.0928231097412;417.4760675352413;425.53191489361456;443.3549185934522;545.7516829842413;556.9888602227933;557.8995780759502;569.4362581044819;6370.012648039561;6816.386525212754;6842.7605033823575;6879.552829066095;6891.896621550681;511.2229411294811;530.5808411355064;555.4001678187548;557.1392199052474;558.0624550754771;3318.2202182487094;3410.744194185446;3437.364087643794;3456.2223499712363;3498.3877821381666;39630.60369396327;59974.10038849421;60089;62021;62273.68863155746;40447.59552404438;41929.79035104805;43112.3533147003;48344.51655483471;53277.73361133169;35453.645463545035;42393.15213695709;42985.785071074446;44205.55794442014;44367.77816110899;7128.714851405885;7207.639618019183;7219.0976127984;7281.817954551178;7530.472866899265;30250.84874575613;30257;30539.54190687097;30608.234794130323;31955.68044319527;33648.663513364554;41398;41460.37809432801;41701.582984170986;42437.57562424336;9491.905080949102;9495;9509.904900950902;9512.667056652985;9622.230221582397;9790.902090979;9883.406995580288;9935.850962235716;10458.633947812094;10641.840372394576;9654.855177172207;9966.950165249418;10002.349847259904;10238.641647542301;10345;9996.900030999597;10091.44497052669;10218.284720069822;10276.126529245097;10374.066334029974;9310.906890931004;9314.627414903329;9476.763080923032;9477.52612369365;9703.223742100756;7459.950823336691;7621.31408173267;7686.692532298869;7727.768166955;7967.725163973736;7787;7958.323542498721;7963.283304502391;7969.123396426273;8082.919170808216 19:07:56 INFO - PROCESS | 2548 | __end_tp_report 19:07:56 INFO - PROCESS | 2548 | __start_cc_report 19:07:56 INFO - PROCESS | 2548 | _x_x_mozilla_cycle_collect,1126 19:07:56 INFO - PROCESS | 2548 | __end_cc_report 19:07:56 INFO - PROCESS | 2548 | __startTimestamp1480043276511__endTimestamp 19:07:56 INFO - PROCESS | 2548 | 19:07:56 INFO - PROCESS | 2548 | ------- Summary: start ------- 19:07:56 INFO - PROCESS | 2548 | Number of tests: 6 19:07:56 INFO - PROCESS | 2548 | 19:07:56 INFO - PROCESS | 2548 | [#0] dojo.html Cycles:165 Average:4227.96 Median:4394.30 stddev:485.65 (11.1%) stddev-sans-first:469.97 19:07:56 INFO - PROCESS | 2548 | Values: 2596.0 2601.3 2611.1 2633.9 2650.5 4347.2 4353.1 4353.8 4369.6 4383.9 4088.8 4152.3 4342.1 4387.8 4407.9 3841.2 3959.0 3983.4 3997.9 4062.6 3953.6 3979.7 4018.5 4033.8 4065.8 3988.8 4014.4 4038.5 4047.4 4067.8 3790.4 3828.5 3932.4 3990.9 4042.5 3943.2 3944.5 3950.5 3957.5 3982.7 4150.4 4299.1 4308.1 4308.3 4334.2 4411.8 4443.3 4460.1 4484.8 4486.7 4503.7 4509.3 4512.1 4527.0 4540.8 4214.9 4223.0 4227.7 4262.7 4266.2 4427.9 4504.6 4507.7 4581.5 4669.9 4474.6 4530.9 4551.7 4558.3 4564.2 4579.4 4583.6 4592.1 4593.3 4638.0 4303.9 4391.6 4394.3 4499.4 4531.0 4409.3 4413.3 4436.6 4446.1 4447.3 3101.8 3105.4 3106.2 3134.2 3136.4 2905.8 2927.7 2950.6 2960.8 2966.4 4278.4 4291.1 4294.6 4304.7 4347.9 4376.5 4403.5 4433.7 4600.2 4660.9 4199.8 4276.2 4277.9 4288.0 4304.5 3805.7 3830.8 3841.2 3846.6 3877.4 4417.7 4544.7 4620.5 4626.7 4659.1 4377.6 4513.7 4589.0 4627.6 4639.7 4656.5 4699.2 4704.0 4711.1 4751.5 4554.7 4577.7 4578.0 4579.9 4613.6 4369.6 4413.0 4559.0 4603.0 4653.3 4519.9 4534.1 4560.4 4579.4 4581.3 4506.9 4526.0 4534.9 4550.7 4582.8 4279.1 4365.6 4382.5 4454.6 4479.4 4489.3 4511.0 4523.1 4524.5 4530.5 4445.7 4450.4 4452.5 4483.1 4491.8 19:07:56 INFO - PROCESS | 2548 | 19:07:56 INFO - PROCESS | 2548 | [#1] ext.html Cycles:180 Average:38985.29 Median:33865.16 stddev:62036.38 (183.2%) stddev-sans-first:62143.29 19:07:56 INFO - PROCESS | 2548 | Values: 552.4 554.8 572.0 596.1 598.9 34161.8 36403.5 36484.6 39396.2 39436.4 36642.6 36740.3 37040.4 37080.6 37084.3 7020.9 7261.1 7694.1 7834.8 7840.5 9368.5 9600.4 9656.3 9669.3 9693.7 9356.4 9371.2 9399.2 9435.5 9439.3 9290.3 9303.6 9366.4 9372.0 9397.3 9252.9 9261.6 9320.4 9323.3 9330.9 33767.3 33910.5 34201.1 34216.0 34276.0 2935.0 3036.7 3069.6 3108.6 3117.6 25447.9 25497.6 25607.4 25664.5 25917.0 3304.3 3318.3 3332.7 3339.6 3433.7 183672.0 211082.0 211484.9 212366.0 212405.0 46186.3 46558.1 46601.0 46606.8 46656.3 49028.3 49160.3 49291.8 49394.5 49481.0 12919.9 13298.9 13300.1 13306.3 13478.4 7377.7 7514.1 9759.1 9856.3 10269.6 15396.5 15409.4 15418.3 15457.7 15641.8 5562.8 5577.6 5594.7 5597.7 5619.2 838.4 858.2 889.8 929.3 977.3 26064.7 26273.5 26425.5 26610.3 26776.7 928.8 951.1 958.1 966.9 1011.7 14017.4 14044.3 14068.7 14204.2 14218.5 122551.0 292224.0 292700.0 293738.0 294002.0 47494.5 47549.8 47598.3 47643.3 47675.8 1074.3 1085.1 1163.7 1195.8 1211.3 24260.8 26927.9 27102.3 27210.9 27379.9 40046.8 40050.6 40536.8 40563.4 40596.2 233104.0 234501.0 235607.0 236469.0 236857.0 23187.7 23914.4 23966.2 33500.8 33819.8 38791.4 39130.2 39201.6 39252.8 39457.0 32649.7 33167.8 33202.5 33273.0 33737.3 32757.2 32982.8 33091.3 33199.8 33542.0 33314.2 33435.3 33504.5 33659.5 34741.8 29400.9 30183.4 30308.7 30449.2 30663.0 22269.9 22594.0 22763.3 23001.8 23066.5 19:07:56 INFO - PROCESS | 2548 | 19:07:56 INFO - PROCESS | 2548 | [#2] jquery.html Cycles:180 Average:19177.03 Median:4746.93 stddev:46445.71 (978.4%) stddev-sans-first:46554.39 19:07:56 INFO - PROCESS | 2548 | Values: 305.1 324.9 326.3 329.7 337.0 11766.0 14731.2 15043.4 15398.4 15870.9 14678.1 14711.3 14749.3 14851.7 14977.7 4629.8 4635.4 4805.9 4806.3 4843.8 4656.0 4785.2 4789.5 4791.5 4793.7 4743.9 4750.0 4750.6 4750.8 4758.1 4529.1 4632.1 4635.2 4653.9 4662.5 4121.2 4121.4 4128.2 4128.8 4132.7 17455.9 17674.2 17780.4 17783.5 17856.7 1932.7 1962.2 2226.4 2260.3 2374.9 11097.3 11773.4 11779.1 12027.8 12167.4 1618.4 1625.9 1677.6 1707.4 1740.0 49503.5 54140.6 56119.2 57579.1 57897.7 7924.7 8202.0 8241.5 8943.7 9044.3 9221.5 9725.6 11098.3 11791.7 11814.0 6062.4 6373.9 6439.1 6487.4 6513.8 6069.5 6101.8 6189.9 6193.8 6202.6 3891.6 3900.6 3903.8 3960.1 3967.5 1672.9 1706.3 1716.8 1724.4 1747.7 800.3 812.0 853.4 869.2 914.4 14786.6 15028.3 15035.4 15144.6 15433.0 875.9 879.0 882.3 898.6 917.4 7831.8 8574.2 8574.6 8879.7 8991.5 278465.0 279214.0 279803.0 280407.0 281973.0 61794.4 63878.7 64023.7 64203.7 64304.7 855.7 882.8 883.5 884.6 884.8 11067.7 13665.2 13780.6 13845.7 14150.3 29924.4 30238.4 30393.5 30441.0 30946.8 41497.8 42974.1 43195.4 43404.6 44054.6 5830.8 6452.5 6537.7 6578.1 6701.1 7560.9 10108.4 10409.5 10477.1 10559.5 8272.0 8495.7 8689.3 8727.5 8826.0 7726.3 7762.1 7762.6 7767.3 8436.6 7719.4 7918.5 8250.8 8465.9 8782.3 6374.7 6432.7 6512.2 6552.6 6601.2 6038.9 7491.5 8463.1 8681.8 8846.2 19:07:56 INFO - PROCESS | 2548 | 19:07:56 INFO - PROCESS | 2548 | [#3] mootools.html Cycles:180 Average:3814.27 Median:4617.15 stddev:1984.67 (43.0%) stddev-sans-first:1980.74 19:07:56 INFO - PROCESS | 2548 | Values: 1230.9 1236.7 1281.8 1462.3 1485.8 5503.5 5892.8 5896.1 5897.8 5902.1 5031.8 5233.3 5233.4 5309.4 5314.1 1738.6 1805.4 1808.1 1823.1 1824.3 1829.5 1847.5 1847.8 1849.0 1849.6 1483.4 1516.5 1772.6 1811.8 1817.5 1703.7 1764.8 1766.9 1771.9 1784.2 1765.6 1781.6 1795.9 1797.6 1799.0 5711.9 5811.4 5840.3 5847.2 5855.6 3517.9 3641.9 3645.3 3645.5 3646.7 2296.0 2346.7 2350.0 2351.6 2351.9 719.8 750.5 759.6 769.3 782.6 7017.8 7089.9 7101.1 7125.6 7136.5 3085.5 3161.5 3224.7 3232.3 3232.8 6104.6 6393.0 6464.2 6474.5 6477.5 3658.2 3665.4 3669.4 3673.4 3678.4 3417.5 3420.5 3421.5 3422.7 3423.9 2788.2 2825.3 2889.4 2889.7 2907.3 909.6 922.6 934.4 946.0 946.4 695.2 733.4 747.5 762.1 763.1 3823.8 3948.5 3965.0 3991.2 4065.6 342.4 346.1 347.0 350.4 352.2 2766.7 2808.4 2823.5 2836.3 2859.0 6540.2 6799.4 6903.0 6904.7 6914.5 6823.8 6849.6 6868.3 6868.9 6870.1 5462.0 5555.6 5558.6 5560.7 5561.9 3873.1 3882.2 3886.8 3919.3 3977.1 6215.6 6324.9 6327.1 6329.9 6347.5 6409.1 6409.3 6420.5 6425.6 6427.0 5028.6 5047.1 5065.7 5104.2 5108.8 5325.6 5490.7 5563.4 5573.5 5582.0 4523.9 5023.9 5051.2 5052.8 5133.7 4732.5 5013.8 5086.7 5118.0 5225.3 4710.4 4784.5 4785.0 4797.2 4802.1 3341.3 3413.8 3425.0 3435.5 3440.1 3471.6 3487.8 3516.5 3527.5 3595.7 19:07:56 INFO - PROCESS | 2548 | 19:07:56 INFO - PROCESS | 2548 | [#4] prototype.html Cycles:180 Average:3880.86 Median:4489.53 stddev:1148.59 (25.6%) stddev-sans-first:1119.10 19:07:56 INFO - PROCESS | 2548 | Values: 255.0 257.0 259.7 260.8 262.4 4441.4 4491.0 4498.9 4501.2 4516.6 4366.6 4406.9 4420.3 4424.4 4432.2 3286.2 3404.7 3448.3 3449.1 3462.4 3368.0 3477.9 3488.4 3491.8 3507.1 3432.6 3467.1 3473.3 3473.5 3487.1 3281.5 3477.4 3484.0 3484.4 3484.5 2851.9 2927.6 2941.5 2945.3 3056.9 4303.0 4351.4 4361.5 4404.4 4431.8 3921.5 3941.8 3943.9 3944.4 3945.8 4530.6 4547.5 4618.3 4636.4 4651.2 3275.6 3279.1 3285.2 3286.5 3307.7 4841.0 4852.2 4854.0 4858.5 4871.2 3354.8 3383.6 3390.3 3398.5 3408.5 3364.4 3381.9 3401.1 3416.8 3447.7 3876.7 3890.9 3894.9 3897.6 3898.5 4602.7 4638.4 4641.4 4659.7 4671.0 1121.7 1134.2 1135.8 1139.4 1141.7 779.7 796.1 800.7 808.0 813.1 4269.6 4269.7 4273.8 4279.0 4305.6 4603.2 4650.3 4700.0 4740.8 4847.9 4440.9 4468.9 4489.8 4494.2 4509.7 2449.7 2489.6 2491.4 2494.7 2498.6 4489.2 4666.4 4671.6 4694.4 4725.6 4718.7 4731.5 4736.5 4748.9 4781.4 4694.5 4705.8 4709.9 4718.6 4729.7 4545.5 4553.0 4656.2 4665.7 4667.9 4594.4 4595.9 4596.3 4608.2 4609.3 4704.4 4710.9 4732.1 4732.7 4732.7 3051.8 3251.0 3261.0 3266.6 3311.4 4830.5 4836.9 4841.9 4844.6 4925.8 4722.7 4745.7 4781.5 4782.8 4800.4 4597.5 4692.8 4769.6 4799.2 4802.6 4632.9 4638.6 4649.4 4656.5 4656.6 4704.3 4710.6 4715.5 4727.3 4751.8 4300.3 4485.7 4627.3 4696.7 4709.1 19:07:56 INFO - PROCESS | 2548 | 19:07:56 INFO - PROCESS | 2548 | [#5] yui.html Cycles:180 Average:12272.22 Median:520.90 stddev:14761.82 (2833.9%) stddev-sans-first:14777.28 19:07:56 INFO - PROCESS | 2548 | Values: 616.6 664.2 695.4 709.2 719.9 11078.9 11660.7 11974.0 12260.2 12273.3 11769.3 11922.0 11945.0 11959.2 11965.2 591.5 609.7 717.6 735.9 743.0 688.7 697.9 699.9 726.7 727.5 801.1 803.5 804.7 805.4 805.5 609.6 624.1 795.2 795.3 797.4 545.9 562.1 568.6 582.0 582.2 10871.4 10919.2 10921.9 10924.7 10933.9 10755.7 10933.3 11026.6 11167.4 11417.9 10060.9 10098.6 10110.0 10130.6 10194.8 3842.6 3843.2 3947.3 3987.0 3998.9 40594.6 41501.0 42412.2 42496.8 42569.4 8794.0 8932.5 8944.4 9037.0 9186.1 15535.1 15541.8 15599.8 15625.8 15626.3 6124.7 6297.7 6327.1 6360.8 6364.2 3580.4 3627.5 3694.3 3703.0 3731.1 2218.6 2491.8 2593.5 2607.5 2619.5 410.2 416.9 417.1 417.5 425.5 443.4 545.8 557.0 557.9 569.4 6370.0 6816.4 6842.8 6879.6 6891.9 511.2 530.6 555.4 557.1 558.1 3318.2 3410.7 3437.4 3456.2 3498.4 39630.6 59974.1 60089.0 62021.0 62273.7 40447.6 41929.8 43112.4 48344.5 53277.7 35453.6 42393.2 42985.8 44205.6 44367.8 7128.7 7207.6 7219.1 7281.8 7530.5 30250.8 30257.0 30539.5 30608.2 31955.7 33648.7 41398.0 41460.4 41701.6 42437.6 9491.9 9495.0 9509.9 9512.7 9622.2 9790.9 9883.4 9935.9 10458.6 10641.8 9654.9 9967.0 10002.3 10238.6 10345.0 9996.9 10091.4 10218.3 10276.1 10374.1 9310.9 9314.6 9476.8 9477.5 9703.2 7460.0 7621.3 7686.7 7727.8 7967.7 7787.0 7958.3 7963.3 7969.1 8082.9 19:07:56 INFO - PROCESS | 2548 | -------- Summary: end -------- 19:07:56 INFO - PROCESS | 2548 | 19:07:57 INFO - TEST-INFO | 2548: exit 0 19:07:57 INFO - TEST-OK | dromaeo_css | took 1123424ms 19:07:57 INFO - TEST-START | kraken 19:07:57 INFO - operating with platform_type : w8_ 19:07:57 INFO - Initialising browser for kraken test... 19:07:57 INFO - TEST-INFO | started process 2216 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmps3xxpo\profile http://localhost:49291/getInfo.html) 19:08:03 INFO - PROCESS | 2216 | __metrics Screen width/height:1600/1200 19:08:03 INFO - PROCESS | 2216 | colorDepth:24 19:08:03 INFO - PROCESS | 2216 | Browser inner width/height: 1010/674 19:08:03 INFO - PROCESS | 2216 | __metrics 19:08:04 INFO - PROCESS | 2216 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:08:04 INFO - PROCESS | 2216 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:08:04 INFO - PROCESS | 2216 | console.error: 19:08:04 INFO - PROCESS | 2216 | Message: Error: Connection closed before committing the transaction. 19:08:04 INFO - PROCESS | 2216 | Stack: 19:08:04 INFO - PROCESS | 2216 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:932:23 19:08:04 INFO - PROCESS | 2216 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 19:08:04 INFO - PROCESS | 2216 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 19:08:04 INFO - PROCESS | 2216 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 19:08:04 INFO - PROCESS | 2216 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 19:08:04 INFO - PROCESS | 2216 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 19:08:04 INFO - PROCESS | 2216 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:550:9 19:08:04 INFO - PROCESS | 2216 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 19:08:04 INFO - PROCESS | 2216 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:386:5 19:08:04 INFO - PROCESS | 2216 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 19:08:04 INFO - PROCESS | 2216 | Barrier/this.client.addBlocker/promise13.4% 19:09:04 INFO - TinderboxPrint: I/O read bytes / time
48,817,152 / 425,660 19:09:04 INFO - TinderboxPrint: I/O write bytes / time
415,313,920 / 3,193,730 19:09:04 INFO - TinderboxPrint: CPU idle
8,263.3 (86.6%) 19:09:04 INFO - TinderboxPrint: CPU user
1,234.4 (12.9%) 19:09:04 INFO - install - Wall time: 3s; CPU: 12.0%; Read bytes: 0; Write bytes: 38509056; Read time: 0; Write time: 51120 19:09:04 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 48801792; Write bytes: 326428160; Read time: 422690; Write time: 3104310 19:09:05 INFO - Running post-run listener: _upload_blobber_files 19:09:05 INFO - Blob upload gear active. 19:09:05 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 19:09:05 INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:09:05 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Graphics', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 19:09:05 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Graphics -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 19:09:05 INFO - (blobuploader) - INFO - Open directory for files ... 19:09:05 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 19:09:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:09:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:06 INFO - (blobuploader) - INFO - Done attempting. 19:09:06 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 19:09:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:09:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:07 INFO - (blobuploader) - INFO - Done attempting. 19:09:07 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 19:09:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:09 INFO - (blobuploader) - INFO - Done attempting. 19:09:09 INFO - (blobuploader) - INFO - Iteration through files over. 19:09:09 INFO - Return code: 0 19:09:09 INFO - rmtree: C:\slave\test\build\uploaded_files.json 19:09:09 INFO - Using _rmtree_windows ... 19:09:09 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 19:09:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a712de791454e5244d6614a8bb0a574bcac96d4fcb868072c09d29b8b3fe12a785d7fbaa62358d7deec2efb292e10043a573541ec7eaf8515dfafdda20e482d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/305bf175ea85fb2f089eb85638238d5e7194228097fb456efd2aeb528a6e8b1c6f0f96c0e43eb671971f56f8cf286db3f50d88d68de592ed16fee16059f35150", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/540db4b12b095aa70d6fd6d07e8953bb23095a5207b1ce1893f5526ab78272eaa42f9c9452a7b325f551bae352d387ca6bc2b31765cccff73909b17e960a7181"} 19:09:09 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 19:09:09 INFO - Writing to file C:\slave\test\properties\blobber_files 19:09:09 INFO - Contents: 19:09:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a712de791454e5244d6614a8bb0a574bcac96d4fcb868072c09d29b8b3fe12a785d7fbaa62358d7deec2efb292e10043a573541ec7eaf8515dfafdda20e482d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/305bf175ea85fb2f089eb85638238d5e7194228097fb456efd2aeb528a6e8b1c6f0f96c0e43eb671971f56f8cf286db3f50d88d68de592ed16fee16059f35150", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/540db4b12b095aa70d6fd6d07e8953bb23095a5207b1ce1893f5526ab78272eaa42f9c9452a7b325f551bae352d387ca6bc2b31765cccff73909b17e960a7181"} 19:09:09 INFO - Running post-run listener: copy_logs_to_upload_dir 19:09:09 INFO - Copying logs to upload dir... 19:09:09 INFO - mkdir: C:\slave\test\build\upload\logs 19:09:09 INFO - Copying logs to upload dir... 19:09:09 INFO - Using _rmtree_windows ... 19:09:09 INFO - Using _rmtree_windows ... 19:09:09 INFO - Using _rmtree_windows ... 19:09:09 INFO - Using _rmtree_windows ... 19:09:09 INFO - Using _rmtree_windows ... 19:09:09 INFO - Using _rmtree_windows ... 19:09:09 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1371.344000 ========= master_lag: 0.03 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 51 secs) (at 2016-11-24 19:09:09.928840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 19:09:09.934549) ========= '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-095\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-095 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-095 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-095\AppData\Local LOGONSERVER=\\T-W864-IX-095 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;C:\mozilla-build\hg 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-095 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-095 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-095 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a712de791454e5244d6614a8bb0a574bcac96d4fcb868072c09d29b8b3fe12a785d7fbaa62358d7deec2efb292e10043a573541ec7eaf8515dfafdda20e482d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/305bf175ea85fb2f089eb85638238d5e7194228097fb456efd2aeb528a6e8b1c6f0f96c0e43eb671971f56f8cf286db3f50d88d68de592ed16fee16059f35150", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/540db4b12b095aa70d6fd6d07e8953bb23095a5207b1ce1893f5526ab78272eaa42f9c9452a7b325f551bae352d387ca6bc2b31765cccff73909b17e960a7181"} build_url:https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/HvJcTVeuSdqM1ee7dvfkhA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a712de791454e5244d6614a8bb0a574bcac96d4fcb868072c09d29b8b3fe12a785d7fbaa62358d7deec2efb292e10043a573541ec7eaf8515dfafdda20e482d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/305bf175ea85fb2f089eb85638238d5e7194228097fb456efd2aeb528a6e8b1c6f0f96c0e43eb671971f56f8cf286db3f50d88d68de592ed16fee16059f35150", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/540db4b12b095aa70d6fd6d07e8953bb23095a5207b1ce1893f5526ab78272eaa42f9c9452a7b325f551bae352d387ca6bc2b31765cccff73909b17e960a7181"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 19:09:10.059472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 19:09:10.059816) ========= '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-095\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-095 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-095 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-095\AppData\Local LOGONSERVER=\\T-W864-IX-095 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;C:\mozilla-build\hg 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-095 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-095 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-095 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 19:09:10.182203) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-11-24 19:09:10.182512) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-11-24 19:09:10.990048) ========= ========= Total master_lag: 0.21 =========