builder: graphics_win8_64_test-dromaeojs slave: t-w864-ix-098 starttime: 1479778283.02 results: success (0) buildid: 20161121080011 builduid: b83800a7b1314f2a879fb28c2998a985 revision: de6d43636e4252fc43371dce0808231e7ff3bea6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 17:31:23.024921) ========= master: http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 17:31:23.025356) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 17:31:23.025638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 17:31:23.130571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 17:31:23.130910) ========= '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-098\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-098 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-098 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-098\AppData\Local LOGONSERVER=\\T-W864-IX-098 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-098 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-098 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-098 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --17:31:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. 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% 8.56 MB/s 17:31:24 (8.56 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.544000 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 17:31:24.730468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-11-21 17:31:24.730819) ========= '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-098\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-098 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-098 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-098\AppData\Local LOGONSERVER=\\T-W864-IX-098 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-098 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-098 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-098 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=4.414000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-11-21 17:31:29.164404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-21 17:31:29.164806) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo projects/graphics --rev de6d43636e4252fc43371dce0808231e7ff3bea6 --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 de6d43636e4252fc43371dce0808231e7ff3bea6 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-098\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-098 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-098 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-098\AppData\Local LOGONSERVER=\\T-W864-IX-098 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-098 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-098 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-098 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-11-21 17:31:29,869 truncating revision to first 12 chars 2016-11-21 17:31:29,869 Setting DEBUG logging. 2016-11-21 17:31:29,869 attempt 1/10 2016-11-21 17:31:29,869 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/de6d43636e42?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 17:31:31,052 unpacking tar archive at: graphics-de6d43636e42/testing/mozharness/ 2016-11-21 17:31:31,157 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=2.280000 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-21 17:31:31.538114) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 17:31:31.538444) ========= script_repo_revision: de6d43636e4252fc43371dce0808231e7ff3bea6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 17:31:31.538872) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 17:31:31.539148) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 17:31:31.560053) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 14 secs) (at 2016-11-21 17:31:31.560327) ========= '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-098\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-098 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-098 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-098\AppData\Local LOGONSERVER=\\T-W864-IX-098 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-098 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-098 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-098 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 17:31:32 INFO - MultiFileLogger online at 20161121 17:31:32 in C:\slave\test 17:31:32 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 17:31:32 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 17:31:32 INFO - {'append_to_log': False, 17:31:32 INFO - 'base_work_dir': 'C:\\slave\\test', 17:31:32 INFO - 'blob_upload_branch': 'Graphics', 17:31:32 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 17:31:32 INFO - 'branch': 'Graphics', 17:31:32 INFO - 'buildbot_json_path': 'buildprops.json', 17:31:32 INFO - 'config_files': ('talos/windows_config.py',), 17:31:32 INFO - 'default_actions': ('clobber', 17:31:32 INFO - 'read-buildbot-config', 17:31:32 INFO - 'download-and-extract', 17:31:32 INFO - 'populate-webroot', 17:31:32 INFO - 'create-virtualenv', 17:31:32 INFO - 'install', 17:31:32 INFO - 'run-tests'), 17:31:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:31:32 INFO - 'download_minidump_stackwalk': True, 17:31:32 INFO - 'download_symbols': 'ondemand', 17:31:32 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 17:31:32 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 17:31:32 INFO - 'hg': 'c:/mozilla-build/hg/hg', 17:31:32 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 17:31:32 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 17:31:32 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 17:31:32 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 17:31:32 INFO - 'C:/mozilla-build/tooltool.py'), 17:31:32 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 17:31:32 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 17:31:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:31:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:31:32 INFO - 'installer_path': 'installer.exe', 17:31:32 INFO - 'log_level': 'info', 17:31:32 INFO - 'log_name': 'talos', 17:31:32 INFO - 'log_to_console': True, 17:31:32 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 17:31:32 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 17:31:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 17:31:32 INFO - 'opt_config_files': (), 17:31:32 INFO - 'pip_index': False, 17:31:32 INFO - 'sps_profile': False, 17:31:32 INFO - 'sps_profile_interval': 0, 17:31:32 INFO - 'suite': 'dromaeojs', 17:31:32 INFO - 'system_bits': '32', 17:31:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:31:32 INFO - 'title': 'T-W864-IX-098', 17:31:32 INFO - 'use_talos_json': True, 17:31:32 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 17:31:32 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 17:31:32 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 17:31:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:31:32 INFO - 'work_dir': 'build'} 17:31:32 INFO - [mozharness: 2016-11-22 01:31:32.028000Z] Running clobber step. 17:31:32 INFO - Running pre-action listener: _resource_record_pre_action 17:31:32 INFO - Running main action method: clobber 17:31:32 INFO - rmtree: C:\slave\test\build 17:31:32 INFO - Using _rmtree_windows ... 17:31:32 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 17:33:10 INFO - Running post-action listener: _resource_record_post_action 17:33:10 INFO - [mozharness: 2016-11-22 01:33:10.551000Z] Finished clobber step (success) 17:33:10 INFO - [mozharness: 2016-11-22 01:33:10.551000Z] Running read-buildbot-config step. 17:33:10 INFO - Running pre-action listener: _resource_record_pre_action 17:33:10 INFO - Running main action method: read_buildbot_config 17:33:10 INFO - Using buildbot properties: 17:33:10 INFO - { 17:33:10 INFO - "project": "", 17:33:10 INFO - "product": "firefox", 17:33:10 INFO - "script_repo_revision": "default", 17:33:10 INFO - "builddir": "graphics_win8_64_test-dromaeojs", 17:33:10 INFO - "repository": "", 17:33:10 INFO - "buildername": "Windows 8 64-bit graphics talos dromaeojs", 17:33:10 INFO - "buildid": "20161121080011", 17:33:10 INFO - "pgo_build": "False", 17:33:10 INFO - "basedir": "C:\\slave\\test", 17:33:10 INFO - "buildnumber": 1, 17:33:10 INFO - "slavename": "t-w864-ix-098", 17:33:10 INFO - "master": "http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/", 17:33:10 INFO - "platform": "win8_64", 17:33:10 INFO - "scheduler": "tests-graphics-win64-talos", 17:33:10 INFO - "branch": "graphics", 17:33:10 INFO - "repo_path": "projects/graphics", 17:33:10 INFO - "revision": "de6d43636e4252fc43371dce0808231e7ff3bea6", 17:33:10 INFO - "stage_platform": "win64", 17:33:10 INFO - "builduid": "b83800a7b1314f2a879fb28c2998a985", 17:33:10 INFO - "slavebuilddir": "test" 17:33:10 INFO - } 17:33:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip. 17:33:10 INFO - Running post-action listener: _resource_record_post_action 17:33:10 INFO - [mozharness: 2016-11-22 01:33:10.554000Z] Finished read-buildbot-config step (success) 17:33:10 INFO - [mozharness: 2016-11-22 01:33:10.555000Z] Running download-and-extract step. 17:33:10 INFO - Running pre-action listener: _resource_record_pre_action 17:33:10 INFO - Running main action method: download_and_extract 17:33:10 INFO - mkdir: C:\slave\test\build\tests 17:33: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')]} 17:33:10 INFO - trying https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.test_packages.json 17:33:10 INFO - Downloading https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/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 17:33:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/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 17:33:11 INFO - Downloaded 1274 bytes. 17:33:11 INFO - Reading from file C:\slave\test\build\firefox-53.0a1.en-US.win64.test_packages.json 17:33:11 INFO - Using the following test package requirements: 17:33:11 INFO - {u'common': [u'firefox-53.0a1.en-US.win64.common.tests.zip'], 17:33:11 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 17:33:11 INFO - u'firefox-53.0a1.en-US.win64.cppunittest.tests.zip'], 17:33:11 INFO - u'gtest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 17:33:11 INFO - u'firefox-53.0a1.en-US.win64.gtest.tests.zip'], 17:33:11 INFO - u'jittest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 17:33:11 INFO - u'jsshell-win64.zip'], 17:33:11 INFO - u'mochitest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 17:33:11 INFO - u'firefox-53.0a1.en-US.win64.mochitest.tests.zip'], 17:33:11 INFO - u'mozbase': [u'firefox-53.0a1.en-US.win64.common.tests.zip'], 17:33:11 INFO - u'reftest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 17:33:11 INFO - u'firefox-53.0a1.en-US.win64.reftest.tests.zip'], 17:33:11 INFO - u'talos': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 17:33:11 INFO - u'firefox-53.0a1.en-US.win64.talos.tests.zip'], 17:33:11 INFO - u'web-platform': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 17:33:11 INFO - u'firefox-53.0a1.en-US.win64.web-platform.tests.zip'], 17:33:11 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 17:33:11 INFO - u'firefox-53.0a1.en-US.win64.xpcshell.tests.zip']} 17:33:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.win64.common.tests.zip'] for test suite category: common 17:33:11 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip 17:33:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip'}, attempt #1 17:33:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip into memory 17:33:12 INFO - Http code: 200 17:33:12 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 17:33:12 INFO - x-amz-cf-id: tE_EZCHGdAU5pGuXFZ17jb_SM1AhLCB3fYp8mLLhNgM4e5bc2_H8ww== 17:33:12 INFO - x-amz-version-id: oqXdNlc18VnpPCi6ommgbvjEUYSeI3Pt 17:33:12 INFO - Expected file size: 17279097 17:33:12 INFO - Obtained file size: 17279097 17:33:33 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 17:33:33 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip 17:33:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip'}, attempt #1 17:33:33 INFO - Fetch https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip into memory 17:33:34 INFO - Http code: 200 17:33:34 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 17:33:34 INFO - x-amz-cf-id: zlqiVVLH7kC_DUSlB37zRXDvkiEuFROLGAL0xz3Zls21CoKooJJsXw== 17:33:34 INFO - x-amz-version-id: oqXdNlc18VnpPCi6ommgbvjEUYSeI3Pt 17:33:34 INFO - Expected file size: 17279097 17:33:34 INFO - Obtained file size: 17279097 17:33:44 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip 17:33:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip'}, attempt #1 17:33:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip into memory 17:33:45 INFO - Http code: 200 17:33:45 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 17:33:45 INFO - x-amz-cf-id: NysfcyqjFkW0KKRnWRufYZfptghFtIJpn6T7aqgZaDjinryhsIYKZA== 17:33:45 INFO - x-amz-version-id: YEW8SXfplfL1wB3uMH2W3eTSrJRluZPK 17:33:45 INFO - Expected file size: 14409392 17:33:45 INFO - Obtained file size: 14409392 17:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:52 INFO - trying https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 17:33:52 INFO - Downloading https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip to C:\slave\test\build\firefox-53.0a1.en-US.win64.zip 17:33:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/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 17:33:54 INFO - Downloaded 57147786 bytes. 17:33:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 17:33:54 INFO - mkdir: C:\slave\test\properties 17:33:54 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 17:33:54 INFO - Writing to file C:\slave\test\properties\build_url 17:33:54 INFO - Contents: 17:33:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 17:33:54 INFO - Running post-action listener: _resource_record_post_action 17:33:54 INFO - Running post-action listener: set_extra_try_arguments 17:33:54 INFO - [mozharness: 2016-11-22 01:33:54.817000Z] Finished download-and-extract step (success) 17:33:54 INFO - [mozharness: 2016-11-22 01:33:54.817000Z] Running populate-webroot step. 17:33:54 INFO - Running pre-action listener: _resource_record_pre_action 17:33:54 INFO - Running main action method: populate_webroot 17:33:54 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 17:33:54 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 17:33:54 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 17:33:54 INFO - u'--tppagecycles', 17:33:54 INFO - u'7'], 17:33:54 INFO - u'tests': [u'tsvgm']}}, 17:33:54 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 17:33:54 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 17:33:54 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 17:33:54 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 17:33:54 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 17:33:54 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 17:33:54 INFO - u'g1': {u'pagesets_name': u'tp5n.zip', 17:33:54 INFO - u'talos_options': [u'--disable-e10s'], 17:33:54 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 17:33:54 INFO - u'g1-e10s': {u'pagesets_name': u'tp5n.zip', 17:33:54 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 17:33:54 INFO - u'g2': {u'pagesets_name': u'tp5n.zip', 17:33:54 INFO - u'talos_options': [u'--disable-e10s'], 17:33:54 INFO - u'tests': [u'damp', u'tps']}, 17:33:54 INFO - u'g2-e10s': {u'pagesets_name': u'tp5n.zip', 17:33:54 INFO - u'tests': [u'damp', u'tps']}, 17:33:54 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 17:33:54 INFO - u'tests': [u'dromaeo_dom']}, 17:33:54 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 17:33:54 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 17:33:54 INFO - u'tests': [u'basic_compositor_video']}, 17:33:54 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 17:33:54 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 17:33:54 INFO - u'tests': [u'a11yr', 17:33:54 INFO - u'ts_paint', 17:33:54 INFO - u'tpaint', 17:33:54 INFO - u'sessionrestore', 17:33:54 INFO - u'sessionrestore_no_auto_restore', 17:33:54 INFO - u'tabpaint']}, 17:33:54 INFO - u'other-e10s': {u'tests': [u'a11yr', 17:33:54 INFO - u'ts_paint', 17:33:54 INFO - u'tpaint', 17:33:54 INFO - u'sessionrestore', 17:33:54 INFO - u'sessionrestore_no_auto_restore', 17:33:54 INFO - u'tabpaint']}, 17:33:54 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 17:33:54 INFO - u'ts_paint', 17:33:54 INFO - u'tpaint', 17:33:54 INFO - u'sessionrestore', 17:33:54 INFO - u'sessionrestore_no_auto_restore', 17:33:54 INFO - u'tabpaint']}, 17:33:54 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 17:33:54 INFO - u'ts_paint', 17:33:54 INFO - u'tpaint', 17:33:54 INFO - u'sessionrestore', 17:33:54 INFO - u'sessionrestore_no_auto_restore', 17:33:54 INFO - u'tabpaint']}, 17:33:54 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 17:33:54 INFO - u'tests': [u'a11yr', 17:33:54 INFO - u'ts_paint', 17:33:54 INFO - u'tpaint', 17:33:54 INFO - u'sessionrestore', 17:33:54 INFO - u'sessionrestore_no_auto_restore', 17:33:54 INFO - u'tabpaint']}, 17:33:54 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 17:33:54 INFO - u'tests': [u'a11yr', 17:33:54 INFO - u'ts_paint', 17:33:54 INFO - u'tpaint', 17:33:54 INFO - u'sessionrestore', 17:33:54 INFO - u'sessionrestore_no_auto_restore', 17:33:54 INFO - u'tabpaint']}, 17:33:54 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 17:33:54 INFO - u'tests': [u'tsvgx', 17:33:54 INFO - u'tsvgr_opacity', 17:33:54 INFO - u'tart', 17:33:54 INFO - u'tscrollx', 17:33:54 INFO - u'cart']}, 17:33:54 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 17:33:54 INFO - u'tsvgr_opacity', 17:33:54 INFO - u'tart', 17:33:54 INFO - u'tscrollx', 17:33:54 INFO - u'cart']}, 17:33:54 INFO - u'tp5o': {u'pagesets_name': u'tp5n.zip', 17:33:54 INFO - u'talos_options': [u'--disable-e10s'], 17:33:54 INFO - u'tests': [u'tp5o']}, 17:33:54 INFO - u'tp5o-e10s': {u'pagesets_name': u'tp5n.zip', 17:33:54 INFO - u'tests': [u'tp5o']}, 17:33:54 INFO - u'xperf': {u'pagesets_name': u'tp5n.zip', 17:33:54 INFO - u'talos_options': [u'--disable-e10s', 17:33:54 INFO - u'--xperf_path', 17:33:54 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:33:54 INFO - u'tests': [u'tp5n']}, 17:33:54 INFO - u'xperf-e10s': {u'pagesets_name': u'tp5n.zip', 17:33:54 INFO - u'talos_options': [u'--xperf_path', 17:33:54 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:33:54 INFO - u'tests': [u'tp5n']}}, 17:33:54 INFO - u'talos.zip': {u'path': u'', 17:33:54 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:33:54 INFO - Running post-action listener: _resource_record_post_action 17:33:54 INFO - [mozharness: 2016-11-22 01:33:54.852000Z] Finished populate-webroot step (success) 17:33:54 INFO - [mozharness: 2016-11-22 01:33:54.852000Z] Running create-virtualenv step. 17:33:54 INFO - Running pre-action listener: _resource_record_pre_action 17:33:54 INFO - Running main action method: create_virtualenv 17:33:54 INFO - Creating virtualenv C:\slave\test\build/venv 17:33:54 INFO - mkdir: C:\slave\test\build\venv\Scripts 17:33:55 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 17:33:55 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'! 17:33:55 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 17:33:55 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 17:34:01 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 17:34:04 INFO - Installing distribute......................................................................................................................................................................................done. 17:34:06 INFO - Return code: 0 17:34:06 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 17:34:06 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 17:34:06 INFO - Reading from file tmpfile_stdout 17:34:06 INFO - Output received: 17:34:06 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 17:34:06 INFO - Using _rmtree_windows ... 17:34:06 INFO - Using _rmtree_windows ... 17:34:06 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 17:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:06 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 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02799020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01D70DA8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022B6E90>, '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 0x01CDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277B5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-098', 'USERDOMAIN': 'T-W864-IX-098', '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-098', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-098', '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-098\\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 17:34:06 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 17:34:06 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 17:34:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:34:06 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 17:34:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:34:06 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:34:06 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:34:06 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 17:34:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:34:06 INFO - 'DCLOCATION': 'SCL3', 17:34:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:34:06 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:34:06 INFO - 'HOMEDRIVE': 'C:', 17:34:06 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 17:34:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:34:06 INFO - 'KTS_VERSION': '1.19c', 17:34:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 17:34:06 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 17:34:06 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:34:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:06 INFO - 'MOZ_NO_REMOTE': '1', 17:34:06 INFO - 'NO_EM_RESTART': '1', 17:34:06 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:34:06 INFO - 'OS': 'Windows_NT', 17:34:06 INFO - 'OURDRIVE': 'C:', 17:34:06 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;', 17:34:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:34:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:34:06 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:34:06 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:34:06 INFO - 'PROCESSOR_LEVEL': '6', 17:34:06 INFO - 'PROCESSOR_REVISION': '1e05', 17:34:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:34:06 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:34:06 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:34:06 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:34:06 INFO - 'PROMPT': '$P$G', 17:34:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:34:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:34:06 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:34:06 INFO - 'PWD': 'C:\\slave\\test', 17:34:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:34:06 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:34:06 INFO - 'SYSTEMDRIVE': 'C:', 17:34:06 INFO - 'SYSTEMROOT': 'C:\\windows', 17:34:06 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:06 INFO - 'TEST1': 'testie', 17:34:06 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:06 INFO - 'USERDOMAIN': 'T-W864-IX-098', 17:34:06 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 17:34:06 INFO - 'USERNAME': 'cltbld', 17:34:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 17:34:06 INFO - 'WINDIR': 'C:\\windows', 17:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:34:07 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:34:07 INFO - Downloading/unpacking pip>=1.5 17:34:12 INFO - Running setup.py egg_info for package pip 17:34:12 INFO - warning: no files found matching 'pip\cacert.pem' 17:34:12 INFO - warning: no files found matching '*.html' under directory 'docs' 17:34:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 17:34:12 INFO - no previously-included directories found matching 'docs\_build\_sources' 17:34:12 INFO - Installing collected packages: pip 17:34:12 INFO - Found existing installation: pip 0.8.2 17:34:12 INFO - Uninstalling pip: 17:34:12 INFO - Successfully uninstalled pip 17:34:12 INFO - Running setup.py install for pip 17:34:12 INFO - warning: no files found matching 'pip\cacert.pem' 17:34:12 INFO - warning: no files found matching '*.html' under directory 'docs' 17:34:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 17:34:12 INFO - no previously-included directories found matching 'docs\_build\_sources' 17:34:12 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 17:34:12 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 17:34:12 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 17:34:12 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 17:34:12 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 17:34:12 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 17:34:12 INFO - Successfully installed pip 17:34:12 INFO - Cleaning up... 17:34:12 INFO - Return code: 0 17:34:12 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 17:34:12 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')]} 17:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:12 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')]} 17:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:12 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 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02799020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01D70DA8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022B6E90>, '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 0x01CDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277B5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-098', 'USERDOMAIN': 'T-W864-IX-098', '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-098', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-098', '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-098\\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 17:34:12 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 17:34:12 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 17:34:12 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:34:12 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 17:34:12 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:34:12 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:34:12 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:34:12 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 17:34:12 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:34:12 INFO - 'DCLOCATION': 'SCL3', 17:34:12 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:34:12 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:34:12 INFO - 'HOMEDRIVE': 'C:', 17:34:12 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 17:34:12 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:34:12 INFO - 'KTS_VERSION': '1.19c', 17:34:12 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 17:34:12 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 17:34:12 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:34:12 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:12 INFO - 'MOZ_NO_REMOTE': '1', 17:34:12 INFO - 'NO_EM_RESTART': '1', 17:34:12 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:34:12 INFO - 'OS': 'Windows_NT', 17:34:12 INFO - 'OURDRIVE': 'C:', 17:34:12 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;', 17:34:12 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:34:12 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:34:12 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:34:12 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:34:12 INFO - 'PROCESSOR_LEVEL': '6', 17:34:12 INFO - 'PROCESSOR_REVISION': '1e05', 17:34:12 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:34:12 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:34:12 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:34:12 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:34:12 INFO - 'PROMPT': '$P$G', 17:34:12 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:34:12 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:34:12 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:34:12 INFO - 'PWD': 'C:\\slave\\test', 17:34:12 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:34:12 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:34:12 INFO - 'SYSTEMDRIVE': 'C:', 17:34:12 INFO - 'SYSTEMROOT': 'C:\\windows', 17:34:12 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:12 INFO - 'TEST1': 'testie', 17:34:12 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:12 INFO - 'USERDOMAIN': 'T-W864-IX-098', 17:34:12 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 17:34:12 INFO - 'USERNAME': 'cltbld', 17:34:12 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 17:34:12 INFO - 'WINDIR': 'C:\\windows', 17:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:14 INFO - Downloading/unpacking psutil>=3.1.1 17:34:14 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 17:34:14 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 17:34:15 INFO - Installing collected packages: psutil 17:34:15 INFO - Successfully installed psutil 17:34:15 INFO - Cleaning up... 17:34:16 INFO - Return code: 0 17:34:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 17:34:16 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')]} 17:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:16 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')]} 17:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:16 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 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02799020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01D70DA8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022B6E90>, '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 0x01CDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277B5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-098', 'USERDOMAIN': 'T-W864-IX-098', '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-098', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-098', '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-098\\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 17:34:16 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 17:34:16 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 17:34:16 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:34:16 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 17:34:16 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:34:16 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:34:16 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:34:16 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 17:34:16 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:34:16 INFO - 'DCLOCATION': 'SCL3', 17:34:16 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:34:16 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:34:16 INFO - 'HOMEDRIVE': 'C:', 17:34:16 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 17:34:16 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:34:16 INFO - 'KTS_VERSION': '1.19c', 17:34:16 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 17:34:16 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 17:34:16 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:34:16 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:16 INFO - 'MOZ_NO_REMOTE': '1', 17:34:16 INFO - 'NO_EM_RESTART': '1', 17:34:16 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:34:16 INFO - 'OS': 'Windows_NT', 17:34:16 INFO - 'OURDRIVE': 'C:', 17:34:16 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;', 17:34:16 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:34:16 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:34:16 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:34:16 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:34:16 INFO - 'PROCESSOR_LEVEL': '6', 17:34:16 INFO - 'PROCESSOR_REVISION': '1e05', 17:34:16 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:34:16 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:34:16 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:34:16 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:34:16 INFO - 'PROMPT': '$P$G', 17:34:16 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:34:16 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:34:16 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:34:16 INFO - 'PWD': 'C:\\slave\\test', 17:34:16 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:34:16 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:34:16 INFO - 'SYSTEMDRIVE': 'C:', 17:34:16 INFO - 'SYSTEMROOT': 'C:\\windows', 17:34:16 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:16 INFO - 'TEST1': 'testie', 17:34:16 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:16 INFO - 'USERDOMAIN': 'T-W864-IX-098', 17:34:16 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 17:34:16 INFO - 'USERNAME': 'cltbld', 17:34:16 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 17:34:16 INFO - 'WINDIR': 'C:\\windows', 17:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34:16 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 17:34:16 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 17:34:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:34:17 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 17:34:17 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) 17:34:17 INFO - Installing collected packages: mozsystemmonitor 17:34:17 INFO - Running setup.py install for mozsystemmonitor 17:34:18 INFO - Successfully installed mozsystemmonitor 17:34:18 INFO - Cleaning up... 17:34:18 INFO - Return code: 0 17:34:18 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 17:34:18 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')]} 17:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:18 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')]} 17:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:18 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 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02799020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01D70DA8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022B6E90>, '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 0x01CDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277B5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-098', 'USERDOMAIN': 'T-W864-IX-098', '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-098', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-098', '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-098\\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 17:34:18 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 17:34:18 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 17:34:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:34:18 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 17:34:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:34:18 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:34:18 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:34:18 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 17:34:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:34:18 INFO - 'DCLOCATION': 'SCL3', 17:34:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:34:18 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:34:18 INFO - 'HOMEDRIVE': 'C:', 17:34:18 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 17:34:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:34:18 INFO - 'KTS_VERSION': '1.19c', 17:34:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 17:34:18 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 17:34:18 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:34:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:18 INFO - 'MOZ_NO_REMOTE': '1', 17:34:18 INFO - 'NO_EM_RESTART': '1', 17:34:18 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:34:18 INFO - 'OS': 'Windows_NT', 17:34:18 INFO - 'OURDRIVE': 'C:', 17:34:18 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;', 17:34:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:34:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:34:18 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:34:18 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:34:18 INFO - 'PROCESSOR_LEVEL': '6', 17:34:18 INFO - 'PROCESSOR_REVISION': '1e05', 17:34:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:34:18 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:34:18 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:34:18 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:34:18 INFO - 'PROMPT': '$P$G', 17:34:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:34:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:34:18 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:34:18 INFO - 'PWD': 'C:\\slave\\test', 17:34:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:34:18 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:34:18 INFO - 'SYSTEMDRIVE': 'C:', 17:34:18 INFO - 'SYSTEMROOT': 'C:\\windows', 17:34:18 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:18 INFO - 'TEST1': 'testie', 17:34:18 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:18 INFO - 'USERDOMAIN': 'T-W864-IX-098', 17:34:18 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 17:34:18 INFO - 'USERNAME': 'cltbld', 17:34:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 17:34:18 INFO - 'WINDIR': 'C:\\windows', 17:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:18 INFO - Downloading/unpacking jsonschema==2.5.1 17:34:18 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 17:34:18 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 17:34:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:34:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:34:19 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 17:34:19 INFO - warning: no files found matching '*.txt' 17:34:19 INFO - no previously-included directories found matching 'build' 17:34:19 INFO - no previously-included directories found matching 'dist' 17:34:19 INFO - no previously-included directories found matching '.git*' 17:34:19 INFO - Installing collected packages: jsonschema, functools32 17:34:19 INFO - Running setup.py install for functools32 17:34:20 INFO - warning: no files found matching '*.txt' 17:34:20 INFO - no previously-included directories found matching 'build' 17:34:20 INFO - no previously-included directories found matching 'dist' 17:34:20 INFO - no previously-included directories found matching '.git*' 17:34:20 INFO - Successfully installed jsonschema functools32 17:34:20 INFO - Cleaning up... 17:34:20 INFO - Return code: 0 17:34:20 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 17:34:20 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')]} 17:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:20 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')]} 17:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:20 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 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02799020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01D70DA8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022B6E90>, '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 0x01CDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277B5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-098', 'USERDOMAIN': 'T-W864-IX-098', '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-098', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-098', '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-098\\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 17:34:20 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 17:34:20 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 17:34:20 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:34:20 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 17:34:20 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:34:20 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:34:20 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:34:20 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 17:34:20 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:34:20 INFO - 'DCLOCATION': 'SCL3', 17:34:20 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:34:20 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:34:20 INFO - 'HOMEDRIVE': 'C:', 17:34:20 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 17:34:20 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:34:20 INFO - 'KTS_VERSION': '1.19c', 17:34:20 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 17:34:20 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 17:34:20 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:34:20 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:20 INFO - 'MOZ_NO_REMOTE': '1', 17:34:20 INFO - 'NO_EM_RESTART': '1', 17:34:20 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:34:20 INFO - 'OS': 'Windows_NT', 17:34:20 INFO - 'OURDRIVE': 'C:', 17:34:20 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;', 17:34:20 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:34:20 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:34:20 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:34:20 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:34:20 INFO - 'PROCESSOR_LEVEL': '6', 17:34:20 INFO - 'PROCESSOR_REVISION': '1e05', 17:34:20 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:34:20 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:34:20 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:34:20 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:34:20 INFO - 'PROMPT': '$P$G', 17:34:20 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:34:20 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:34:20 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:34:20 INFO - 'PWD': 'C:\\slave\\test', 17:34:20 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:34:20 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:34:20 INFO - 'SYSTEMDRIVE': 'C:', 17:34:20 INFO - 'SYSTEMROOT': 'C:\\windows', 17:34:20 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:20 INFO - 'TEST1': 'testie', 17:34:20 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:20 INFO - 'USERDOMAIN': 'T-W864-IX-098', 17:34:20 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 17:34:20 INFO - 'USERNAME': 'cltbld', 17:34:20 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 17:34:20 INFO - 'WINDIR': 'C:\\windows', 17:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 17:34:20 INFO - Cleaning up... 17:34:20 INFO - Return code: 0 17:34:20 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 17:34:20 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')]} 17:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:20 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')]} 17:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:20 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 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02799020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01D70DA8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022B6E90>, '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 0x01CDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277B5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-098', 'USERDOMAIN': 'T-W864-IX-098', '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-098', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-098', '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-098\\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 17:34:21 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 17:34:21 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 17:34:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:34:21 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 17:34:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:34:21 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:34:21 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:34:21 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 17:34:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:34:21 INFO - 'DCLOCATION': 'SCL3', 17:34:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:34:21 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:34:21 INFO - 'HOMEDRIVE': 'C:', 17:34:21 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 17:34:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:34:21 INFO - 'KTS_VERSION': '1.19c', 17:34:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 17:34:21 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 17:34:21 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:34:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:21 INFO - 'MOZ_NO_REMOTE': '1', 17:34:21 INFO - 'NO_EM_RESTART': '1', 17:34:21 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:34:21 INFO - 'OS': 'Windows_NT', 17:34:21 INFO - 'OURDRIVE': 'C:', 17:34:21 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;', 17:34:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:34:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:34:21 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:34:21 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:34:21 INFO - 'PROCESSOR_LEVEL': '6', 17:34:21 INFO - 'PROCESSOR_REVISION': '1e05', 17:34:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:34:21 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:34:21 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:34:21 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:34:21 INFO - 'PROMPT': '$P$G', 17:34:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:34:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:34:21 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:34:21 INFO - 'PWD': 'C:\\slave\\test', 17:34:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:34:21 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:34:21 INFO - 'SYSTEMDRIVE': 'C:', 17:34:21 INFO - 'SYSTEMROOT': 'C:\\windows', 17:34:21 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:21 INFO - 'TEST1': 'testie', 17:34:21 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:21 INFO - 'USERDOMAIN': 'T-W864-IX-098', 17:34:21 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 17:34:21 INFO - 'USERNAME': 'cltbld', 17:34:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 17:34:21 INFO - 'WINDIR': 'C:\\windows', 17:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:21 INFO - Downloading/unpacking blobuploader==1.2.4 17:34:21 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 17:34:21 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 17:34:22 INFO - Downloading blobuploader-1.2.4.tar.gz 17:34:22 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 17:34:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:34:22 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 17:34:22 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 17:34:22 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 17:34:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:34:22 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 17:34:22 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 17:34:23 INFO - Downloading docopt-0.6.1.tar.gz 17:34:23 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 17:34:23 INFO - Installing collected packages: blobuploader, requests, docopt 17:34:23 INFO - Running setup.py install for blobuploader 17:34:23 INFO - Running setup.py install for requests 17:34:23 INFO - Running setup.py install for docopt 17:34:23 INFO - Successfully installed blobuploader requests docopt 17:34:23 INFO - Cleaning up... 17:34:25 INFO - Return code: 0 17:34:25 INFO - Installing None into virtualenv C:\slave\test\build/venv 17:34:25 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')]} 17:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:25 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')]} 17:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:25 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 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02799020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01D70DA8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022B6E90>, '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 0x01CDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277B5C0>, '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-098', 'USERDOMAIN': 'T-W864-IX-098', '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-098', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-098', '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-098\\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 17:34:25 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 17:34:25 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 17:34:25 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:34:25 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 17:34:25 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:34:25 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:34:25 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:34:25 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 17:34:25 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:34:25 INFO - 'DCLOCATION': 'SCL3', 17:34:25 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:34:25 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:34:25 INFO - 'HOMEDRIVE': 'C:', 17:34:25 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 17:34:25 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:34:25 INFO - 'KTS_VERSION': '1.19c', 17:34:25 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 17:34:25 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 17:34:25 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:34:25 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:25 INFO - 'MOZ_NO_REMOTE': '1', 17:34:25 INFO - 'NO_EM_RESTART': '1', 17:34:25 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:34:25 INFO - 'OS': 'Windows_NT', 17:34:25 INFO - 'OURDRIVE': 'C:', 17:34:25 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;', 17:34:25 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:34:25 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:34:25 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:34:25 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:34:25 INFO - 'PROCESSOR_LEVEL': '6', 17:34:25 INFO - 'PROCESSOR_REVISION': '1e05', 17:34:25 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:34:25 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:34:25 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:34:25 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:34:25 INFO - 'PROMPT': '$P$G', 17:34:25 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:34:25 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:34:25 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:34:25 INFO - 'PWD': 'C:\\slave\\test', 17:34:25 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:34:25 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:34:25 INFO - 'SYSTEMDRIVE': 'C:', 17:34:25 INFO - 'SYSTEMROOT': 'C:\\windows', 17:34:25 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:25 INFO - 'TEST1': 'testie', 17:34:25 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:25 INFO - 'USERDOMAIN': 'T-W864-IX-098', 17:34:25 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 17:34:25 INFO - 'USERNAME': 'cltbld', 17:34:25 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 17:34:25 INFO - 'WINDIR': 'C:\\windows', 17:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 17:34:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-coscvn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 17:34:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 17:34:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nubcnq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 17:34:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 17:34:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o20yst-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 17:34:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 17:34:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lnsmrs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 17:34:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 17:34:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bvi5jx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 17:34:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 17:34:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vuwoux-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 17:34:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 17:34:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nwbyyf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 17:34:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 17:34:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rbfxgg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 17:34:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 17:34:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zbwwlx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 17:34:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 17:34:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kafpnl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 17:34:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 17:34:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lrplhi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 17:34:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 17:34:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kezy0g-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 17:34:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 17:34:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_lg6o2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 17:34:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 17:34:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rupuu_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 17:34:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 17:34:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-aztt6w-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 17:34:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 17:34:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-g7jbk0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 17:34:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 17:34:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-w4xf3m-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 17:34:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:34:27 INFO - Running setup.py install for manifestparser 17:34:27 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 17:34:27 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 17:34:28 INFO - Running setup.py install for mozcrash 17:34:28 INFO - Running setup.py install for mozdebug 17:34:28 INFO - Running setup.py install for mozdevice 17:34:29 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 17:34:29 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 17:34:29 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 17:34:29 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 17:34:29 INFO - Running setup.py install for mozfile 17:34:29 INFO - Running setup.py install for mozhttpd 17:34:30 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 17:34:30 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 17:34:30 INFO - Running setup.py install for mozinfo 17:34:30 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 17:34:30 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 17:34:30 INFO - Running setup.py install for mozInstall 17:34:30 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 17:34:30 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 17:34:30 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 17:34:30 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 17:34:30 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 17:34:30 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 17:34:30 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 17:34:30 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 17:34:31 INFO - Running setup.py install for mozleak 17:34:31 INFO - Running setup.py install for mozlog 17:34:31 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 17:34:31 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 17:34:32 INFO - Running setup.py install for moznetwork 17:34:32 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 17:34:32 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 17:34:32 INFO - Running setup.py install for mozprocess 17:34:33 INFO - Running setup.py install for mozprofile 17:34:33 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 17:34:33 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 17:34:33 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 17:34:33 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 17:34:33 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 17:34:33 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 17:34:33 INFO - Running setup.py install for mozrunner 17:34:34 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 17:34:34 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 17:34:34 INFO - Running setup.py install for mozscreenshot 17:34:34 INFO - Running setup.py install for moztest 17:34:35 INFO - Running setup.py install for mozversion 17:34:35 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 17:34:35 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 17:34:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:34:35 INFO - Cleaning up... 17:34:35 INFO - Return code: 0 17:34:35 INFO - Installing None into virtualenv C:\slave\test\build/venv 17:34: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')]} 17:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34: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')]} 17:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:35 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 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02799020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01D70DA8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022B6E90>, '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 0x01CDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277B5C0>, '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-098', 'USERDOMAIN': 'T-W864-IX-098', '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-098', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-098', '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-098\\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 17:34:35 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 17:34:35 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 17:34:35 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:34:35 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 17:34:35 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:34:35 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:34:35 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:34:35 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 17:34:35 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:34:35 INFO - 'DCLOCATION': 'SCL3', 17:34:35 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:34:35 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:34:35 INFO - 'HOMEDRIVE': 'C:', 17:34:35 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 17:34:35 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:34:35 INFO - 'KTS_VERSION': '1.19c', 17:34:35 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 17:34:35 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 17:34:35 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:34:35 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:35 INFO - 'MOZ_NO_REMOTE': '1', 17:34:35 INFO - 'NO_EM_RESTART': '1', 17:34:35 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:34:35 INFO - 'OS': 'Windows_NT', 17:34:35 INFO - 'OURDRIVE': 'C:', 17:34: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;', 17:34:35 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:34:35 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:34:35 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:34:35 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:34:35 INFO - 'PROCESSOR_LEVEL': '6', 17:34:35 INFO - 'PROCESSOR_REVISION': '1e05', 17:34:35 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:34:35 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:34:35 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:34:35 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:34:35 INFO - 'PROMPT': '$P$G', 17:34:35 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:34:35 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:34:35 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:34:35 INFO - 'PWD': 'C:\\slave\\test', 17:34:35 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:34:35 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:34:35 INFO - 'SYSTEMDRIVE': 'C:', 17:34:35 INFO - 'SYSTEMROOT': 'C:\\windows', 17:34:35 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:35 INFO - 'TEST1': 'testie', 17:34:35 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:35 INFO - 'USERDOMAIN': 'T-W864-IX-098', 17:34:35 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 17:34:35 INFO - 'USERNAME': 'cltbld', 17:34:35 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 17:34:35 INFO - 'WINDIR': 'C:\\windows', 17:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 17:34:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dk4oac-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 17:34:36 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)) 17:34:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 17:34:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0i5g9i-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 17:34:36 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)) 17:34:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 17:34:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ycpegk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 17:34:36 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)) 17:34:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 17:34:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-c8b_pu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 17:34:36 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)) 17:34:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 17:34:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bqn3hg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 17:34:36 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)) 17:34:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 17:34:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3knepy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 17:34:36 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)) 17:34:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 17:34:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0wlecc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 17:34:36 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)) 17:34:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 17:34:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-aglbus-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 17:34:36 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)) 17:34:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 17:34:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dxcmpm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 17:34:37 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)) 17:34:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 17:34:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ktekyn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 17:34:37 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)) 17:34:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 17:34:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-i8rvog-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 17:34:37 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)) 17:34:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 17:34:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jvoiz4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 17:34:37 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)) 17:34:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 17:34:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fi4zxa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 17:34:37 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)) 17:34:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 17:34:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-db7ead-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 17:34:37 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)) 17:34:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 17:34:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wfdozf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 17:34:37 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)) 17:34:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 17:34:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hyuq45-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 17:34:37 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)) 17:34:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 17:34:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lcsudd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 17:34:37 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)) 17:34:37 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)) 17:34:37 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)) 17:34:37 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)) 17:34:37 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)) 17:34:37 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)) 17:34:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 17:34:37 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 17:34:37 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 17:34:39 INFO - Downloading blessings-1.6.tar.gz 17:34:39 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 17:34:39 INFO - Installing collected packages: blessings 17:34:39 INFO - Running setup.py install for blessings 17:34:39 INFO - Successfully installed blessings 17:34:39 INFO - Cleaning up... 17:34:42 INFO - Return code: 0 17:34:42 INFO - Done creating virtualenv C:\slave\test\build/venv. 17:34:42 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 17:34:42 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 17:34:43 INFO - Reading from file tmpfile_stdout 17:34:43 INFO - Using _rmtree_windows ... 17:34:43 INFO - Using _rmtree_windows ... 17:34:43 INFO - Current package versions: 17:34:43 INFO - blessings == 1.6 17:34:43 INFO - blobuploader == 1.2.4 17:34:43 INFO - docopt == 0.6.1 17:34:43 INFO - functools32 == 3.2.3-2 17:34:43 INFO - jsonschema == 2.5.1 17:34:43 INFO - manifestparser == 1.1 17:34:43 INFO - mozInstall == 1.12 17:34:43 INFO - mozcrash == 1.0 17:34:43 INFO - mozdebug == 0.1 17:34:43 INFO - mozdevice == 0.49 17:34:43 INFO - mozfile == 1.2 17:34:43 INFO - mozhttpd == 0.7 17:34:43 INFO - mozinfo == 0.9 17:34:43 INFO - mozleak == 0.1 17:34:43 INFO - mozlog == 3.4 17:34:43 INFO - moznetwork == 0.27 17:34:43 INFO - mozprocess == 0.23 17:34:43 INFO - mozprofile == 0.28 17:34:43 INFO - mozrunner == 6.13 17:34:43 INFO - mozscreenshot == 0.1 17:34:43 INFO - mozsystemmonitor == 0.3 17:34:43 INFO - moztest == 0.7 17:34:43 INFO - mozversion == 1.4 17:34:43 INFO - psutil == 3.1.1 17:34:43 INFO - requests == 1.2.3 17:34:43 INFO - Installing None into virtualenv C:\slave\test\build/venv 17:34: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')]} 17:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34: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')]} 17:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:43 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 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02799020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01D70DA8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022B6E90>, '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 0x01CDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277B5C0>, '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-098', 'USERDOMAIN': 'T-W864-IX-098', '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-098', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-098', '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-098\\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 17:34:43 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 17:34:43 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 17:34:43 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:34:43 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 17:34:43 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:34:43 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:34:43 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:34:43 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 17:34:43 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:34:43 INFO - 'DCLOCATION': 'SCL3', 17:34:43 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:34:43 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:34:43 INFO - 'HOMEDRIVE': 'C:', 17:34:43 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 17:34:43 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:34:43 INFO - 'KTS_VERSION': '1.19c', 17:34:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 17:34:43 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 17:34:43 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:34:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:43 INFO - 'MOZ_NO_REMOTE': '1', 17:34:43 INFO - 'NO_EM_RESTART': '1', 17:34:43 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:34:43 INFO - 'OS': 'Windows_NT', 17:34:43 INFO - 'OURDRIVE': 'C:', 17:34: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;', 17:34:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:34:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:34:43 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:34:43 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:34:43 INFO - 'PROCESSOR_LEVEL': '6', 17:34:43 INFO - 'PROCESSOR_REVISION': '1e05', 17:34:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:34:43 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:34:43 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:34:43 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:34:43 INFO - 'PROMPT': '$P$G', 17:34:43 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:34:43 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:34:43 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:34:43 INFO - 'PWD': 'C:\\slave\\test', 17:34:43 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:34:43 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:34:43 INFO - 'SYSTEMDRIVE': 'C:', 17:34:43 INFO - 'SYSTEMROOT': 'C:\\windows', 17:34:43 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:43 INFO - 'TEST1': 'testie', 17:34:43 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:43 INFO - 'USERDOMAIN': 'T-W864-IX-098', 17:34:43 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 17:34:43 INFO - 'USERNAME': 'cltbld', 17:34:43 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 17:34:43 INFO - 'WINDIR': 'C:\\windows', 17:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:43 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)) 17:34:43 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)) 17:34:43 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)) 17:34:43 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)) 17:34:43 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)) 17:34:43 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)) 17:34:43 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)) 17:34:43 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)) 17:34:43 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)) 17:34:43 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)) 17:34:43 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)) 17:34:43 INFO - Cleaning up... 17:34:43 INFO - Return code: 0 17:34:43 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 17:34: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')]} 17:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34: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')]} 17:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02799020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01D70DA8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022B6E90>, '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 0x01CDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277B5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-098', 'USERDOMAIN': 'T-W864-IX-098', '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-098', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-098', '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-098\\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 17:34: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', 'jsonschema'] in C:\slave\test\build 17:34: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 jsonschema 17:34:43 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:34:43 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 17:34:43 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:34:43 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:34:43 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:34:43 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 17:34:43 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:34:43 INFO - 'DCLOCATION': 'SCL3', 17:34:43 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:34:43 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:34:43 INFO - 'HOMEDRIVE': 'C:', 17:34:43 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 17:34:43 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:34:43 INFO - 'KTS_VERSION': '1.19c', 17:34:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 17:34:43 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 17:34:43 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:34:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:43 INFO - 'MOZ_NO_REMOTE': '1', 17:34:43 INFO - 'NO_EM_RESTART': '1', 17:34:43 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:34:43 INFO - 'OS': 'Windows_NT', 17:34:43 INFO - 'OURDRIVE': 'C:', 17:34: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;', 17:34:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:34:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:34:43 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:34:43 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:34:43 INFO - 'PROCESSOR_LEVEL': '6', 17:34:43 INFO - 'PROCESSOR_REVISION': '1e05', 17:34:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:34:43 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:34:43 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:34:43 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:34:43 INFO - 'PROMPT': '$P$G', 17:34:43 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:34:43 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:34:43 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:34:43 INFO - 'PWD': 'C:\\slave\\test', 17:34:43 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:34:43 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:34:43 INFO - 'SYSTEMDRIVE': 'C:', 17:34:43 INFO - 'SYSTEMROOT': 'C:\\windows', 17:34:43 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:43 INFO - 'TEST1': 'testie', 17:34:43 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:43 INFO - 'USERDOMAIN': 'T-W864-IX-098', 17:34:43 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 17:34:43 INFO - 'USERNAME': 'cltbld', 17:34:43 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 17:34:43 INFO - 'WINDIR': 'C:\\windows', 17:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 17:34:43 INFO - Cleaning up... 17:34:43 INFO - Return code: 0 17:34:43 INFO - Running post-action listener: _resource_record_post_action 17:34:43 INFO - Running post-action listener: _start_resource_monitoring 17:34:43 INFO - Starting resource monitoring. 17:34:43 INFO - [mozharness: 2016-11-22 01:34:43.923000Z] Finished create-virtualenv step (success) 17:34:43 INFO - [mozharness: 2016-11-22 01:34:43.923000Z] Running install step. 17:34:43 INFO - Running pre-action listener: _resource_record_pre_action 17:34:43 INFO - Running main action method: install 17:34:43 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 17:34:43 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 17:34:44 INFO - Reading from file tmpfile_stdout 17:34:44 INFO - Using _rmtree_windows ... 17:34:44 INFO - Using _rmtree_windows ... 17:34:44 INFO - Detecting whether we're running mozinstall >=1.0... 17:34:44 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 17:34:44 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 17:34:44 INFO - Reading from file tmpfile_stdout 17:34:44 INFO - Output received: 17:34:44 INFO - Usage: mozinstall-script.py [options] installer 17:34:44 INFO - Options: 17:34:44 INFO - -h, --help show this help message and exit 17:34:44 INFO - -d DEST, --destination=DEST 17:34:44 INFO - Directory to install application into. [default: 17:34:44 INFO - "C:\slave\test"] 17:34:44 INFO - --app=APP Application being installed. [default: firefox] 17:34:44 INFO - Using _rmtree_windows ... 17:34:44 INFO - Using _rmtree_windows ... 17:34:44 INFO - mkdir: C:\slave\test\build\application 17:34:44 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'] 17:34:44 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 17:34:46 INFO - Reading from file tmpfile_stdout 17:34:46 INFO - Output received: 17:34:46 INFO - C:\slave\test\build\application\firefox\firefox.exe 17:34:46 INFO - Using _rmtree_windows ... 17:34:46 INFO - Using _rmtree_windows ... 17:34:46 INFO - Running post-action listener: _resource_record_post_action 17:34:46 INFO - [mozharness: 2016-11-22 01:34:46.668000Z] Finished install step (success) 17:34:46 INFO - [mozharness: 2016-11-22 01:34:46.668000Z] Running run-tests step. 17:34:46 INFO - Running pre-action listener: _resource_record_pre_action 17:34:46 INFO - Running main action method: run_tests 17:34:46 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 17:34:46 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 17:34:46 INFO - Python 2.7.3 17:34:46 INFO - Return code: 0 17:34:46 INFO - grabbing minidump binary from tooltool 17:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:46 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 0x022B6E90>, '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 0x01CDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277B5C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 17:34:46 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 17:34:46 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 17:34:46 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 17:34:46 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 17:34:46 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpq3jjqc 17:34:46 INFO - INFO - File integrity verified, renaming tmpq3jjqc to win32-minidump_stackwalk.exe 17:34:47 INFO - Return code: 0 17:34:47 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 17:34:47 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 17:34:47 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 17:34:47 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 17:34:47 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 17:34:47 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/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-098', '--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 17:34:47 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/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-098 --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 17:34:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:34:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 17:34:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:34:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:34:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:34:47 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 17:34:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:34:47 INFO - 'DCLOCATION': 'SCL3', 17:34:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:34:47 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:34:47 INFO - 'HOMEDRIVE': 'C:', 17:34:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 17:34:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:34:47 INFO - 'KTS_VERSION': '1.19c', 17:34:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 17:34:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 17:34:47 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 17:34:47 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 17:34:47 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:34:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:47 INFO - 'MOZ_NO_REMOTE': '1', 17:34:47 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 17:34:47 INFO - 'NO_EM_RESTART': '1', 17:34:47 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:34:47 INFO - 'OS': 'Windows_NT', 17:34:47 INFO - 'OURDRIVE': 'C:', 17:34: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;', 17:34:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:34:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:34:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:34:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:34:47 INFO - 'PROCESSOR_LEVEL': '6', 17:34:47 INFO - 'PROCESSOR_REVISION': '1e05', 17:34:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:34:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:34:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:34:47 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:34:47 INFO - 'PROMPT': '$P$G', 17:34:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:34:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:34:47 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:34:47 INFO - 'PWD': 'C:\\slave\\test', 17:34:47 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 17:34:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:34:47 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:34:47 INFO - 'SYSTEMDRIVE': 'C:', 17:34:47 INFO - 'SYSTEMROOT': 'C:\\windows', 17:34:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:47 INFO - 'TEST1': 'testie', 17:34:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:34:47 INFO - 'USERDOMAIN': 'T-W864-IX-098', 17:34:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 17:34:47 INFO - 'USERNAME': 'cltbld', 17:34:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 17:34:47 INFO - 'WINDIR': 'C:\\windows', 17:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:34:47 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/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-098', '--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 17:34:47 INFO - mozversion application_buildid: 20161121080011 17:34:47 INFO - mozversion application_changeset: de6d43636e4252fc43371dce0808231e7ff3bea6 17:34:47 INFO - mozversion application_display_name: Nightly 17:34:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:34:47 INFO - mozversion application_name: Firefox 17:34:47 INFO - mozversion application_remotingname: firefox 17:34:47 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 17:34:47 INFO - mozversion application_vendor: Mozilla 17:34:47 INFO - mozversion application_version: 53.0a1 17:34:47 INFO - mozversion platform_buildid: 20161121080011 17:34:47 INFO - mozversion platform_changeset: de6d43636e4252fc43371dce0808231e7ff3bea6 17:34:47 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 17:34:47 INFO - mozversion platform_version: 53.0a1 17:34:47 INFO - using testdate: 1479778487 17:34:47 INFO - actual date: 1479778487 17:34:47 INFO - starting webserver on 'localhost:49274' 17:34:47 INFO - SUITE-START | Running 2 tests 17:34:47 INFO - TEST-START | dromaeo_css 17:34:47 INFO - operating with platform_type : w8_ 17:34:47 INFO - Initialising browser for dromaeo_css test... 17:34:48 INFO - TEST-INFO | started process 2936 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmptmeqvl\profile http://localhost:49274/getInfo.html) 17:34:56 INFO - PROCESS | 2936 | __metrics Screen width/height:1600/1200 17:34:56 INFO - PROCESS | 2936 | colorDepth:24 17:34:56 INFO - PROCESS | 2936 | Browser inner width/height: 1010/674 17:34:56 INFO - PROCESS | 2936 | __metrics 17:34:57 INFO - PROCESS | 2936 | 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" 17:34:57 INFO - PROCESS | 2936 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:34:58 INFO - TEST-INFO | 2936: exit 0 17:34:58 INFO - Browser initialized. 17:34:58 INFO - Running cycle 1/1 for dromaeo_css test... 17:34:58 INFO - TEST-INFO | started process 2428 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmptmeqvl\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:59 INFO - PROCESS | 2428 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 17:35:10 INFO - PROCESS | 2428 | RSS: Main: 175878144 17:35:10 INFO - PROCESS | 2428 | 17:36:01 INFO - PROCESS | 2428 | 1479778561815 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] 17:38:13 INFO - PROCESS | 2428 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 17:38:15 INFO - PROCESS | 2428 | RSS: Main: 266256384 17:38:15 INFO - PROCESS | 2428 | 17:41:18 INFO - PROCESS | 2428 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 17:41:18 INFO - PROCESS | 2428 | RSS: Main: 233676800 17:41:18 INFO - PROCESS | 2428 | 17:44:21 INFO - PROCESS | 2428 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 17:44:21 INFO - PROCESS | 2428 | RSS: Main: 175251456 17:44:21 INFO - PROCESS | 2428 | 17:47:24 INFO - PROCESS | 2428 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 17:47:25 INFO - PROCESS | 2428 | RSS: Main: 166166528 17:47:25 INFO - PROCESS | 2428 | 17:50:28 INFO - PROCESS | 2428 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 17:50:29 INFO - PROCESS | 2428 | RSS: Main: 164335616 17:50:29 INFO - PROCESS | 2428 | 17:53:32 INFO - PROCESS | 2428 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 17:53:32 INFO - PROCESS | 2428 | RSS: Main: 212480000 17:53:32 INFO - PROCESS | 2428 | 17:53:32 INFO - PROCESS | 2428 | __start_tp_report 17:53:32 INFO - PROCESS | 2428 | _x_x_mozilla_page_load 17:53:32 INFO - PROCESS | 2428 | _x_x_mozilla_page_load_details 17:53:32 INFO - PROCESS | 2428 | |i|pagename|runs| 17:53:32 INFO - PROCESS | 2428 | |0;dojo.html;2663.041305130153;2685.785137189025;2712.213458097152;2717.891284348626;2728.1133631569733;4420.845270415536;4437.068215674708;4469.240229161042;4486.753228572427;4520.299353600189;4322.438083049199;4376.234159022174;4436.578525040124;4437.84467543636;4467.084247729216;4060.3503439449696;4066.3087275163143;4067.3695577185435;4076.368162934735;4109.671226301889;4085.59144085592;4090.3455447128467;4114.876553703393;4122.505299364066;4130.8141133648905;4067.3288907330257;4096.75419474831;4106.650934670557;4119.979400102995;4120.649744771698;4088.4889388826546;4105.8973525661795;4151.481064866892;4166;4173.853915112987;3758.774473531597;4106.917861642751;4107.199096176247;4138.461999940018;4140.565240649718;4166.895827604334;4177.143685544456;4278.973046468856;4355.1072030234045;4362.498312694049;4590.380298659705;4590.495045544987;4642.326862604938;4643.419572553431;4643.582077612998;4600.585947264763;4614.261718125117;4675.742834144121;4682.789274482622;4728.1252968201;4243.299855523835;4287.378330142112;4334.306510958231;4344.804483798237;4390.363397307373;4787.880302992453;4787.952120478821;4792.065547218259;4793.880152996203;4842.201036828954;4414.779261037;4543.1822271990695;4608.28571571407;4621.260598304255;4667.579917807414;4508.436445444319;4530.569595888385;4656.8602941911795;4707.670463067621;4708.952910470852;4630.83792067276;4656.8137274508645;4658.487566367765;4694.741789201558;4697.694649847749;4635.466921304093;4649.465311489154;4651.790669419885;4693.81224751013;4699.412573428322;3086.984565077205;3137.482315417976;3142.6700196479496;3157.36852629475;3194.8881789137267;2920.985395073011;2971.524556071018;2986.313147975934;2992.7456166226116;3012.5481177823503;4333.111712099012;4343.391925130484;4351.12977404514;4354.6951713380395;4375.7374557526655;4613.815447382067;4678.3216433616935;4682.81268749253;4690.788914498856;4699.906001879944;4172.102997855475;4189.476315460567;4237.957620423818;4268.381084742757;4346.47842258931;3830.3871380578976;3841.846326146923;3853.959430953627;3863.478430411915;3867;4636.930446043312;4641.837535686234;4642.117997580449;4644.442666879996;4657.46439159501;4536.047430039728;4565.178267911808;4581.518940511199;4645.581897629229;4700.882477937942;4784.712917224978;4824.276358546246;4826.420829500342;4834.323194752667;4837.201861692782;4642.744649044335;4653.23221668421;4665;4666.62666986647;4707.317438971399;4549.112922979987;4698.2952557116705;4704.811807527797;4711.128441238382;4715.882102947454;4480.596746292849;4506.909861802811;4525.230710779109;4552.931706024478;4618.214903466352;4532.682712210246;4570.405847239837;4579.198640238012;4582.450105987303;4607.3549703040935;4511.954880451153;4514.796834142406;4518.073794871978;4518.615917647036;4558.726476411426;4434.600885920283;4440.844570440019;4476.529964353696;4490.753008584559;4523.163214805271;4412.955870441255;4458.041521072985;4460.9107817844115;4461.397711308931;4471.642268618438 17:53:32 INFO - PROCESS | 2428 | |1;ext.html;559.2757379193944;564.4355644355643;587.2277954489846;587.7737071227576;596.2040675697943;25913.352166195855;37968.81015594921;39081;39173.80413097938;39188.60811391885;34937.3012539749;35090.12274693127;35503.82248088756;35515.822420887926;35532.82233588835;7529.134149572801;7637.198094200112;7651;7668.616569171547;7681.231876812302;7645.350145237661;7702.152763196044;7726.8454630907345;7727.88408173875;7736;7754.457187996814;7760.107587627439;7790.80522986927;7792.727254546092;7797.454178207499;7711.26742959418;7760.611969401564;7762.922370776277;7772.7668169954995;7800.102988156378;7627.8855817162785;7701.3068823806125;7702.345300649452;7705.614719264015;7710.57591832449;33714.437117875525;33849.32301353959;34072.14819629504;34092.48861267083;34137.829310853536;2866.097179388507;2898.6376702912135;2983.970160298413;2992.7605791536625;3085.9074227773203;25899;26083.608745868827;26370.47259054808;26452.73547264522;26489.73510264892;3557.7509574329806;3595.9640403596154;3646.9452958205648;3669.8165091745573;3674.7427680062406;187588;187797;188940.055299724;188974;189284;46138;46241;46530.30204546935;46621.30068048982;46637.968532045306;29694.257643558652;29711.40577188444;29806.403871922874;32461.513077303858;48799.26801097986;14322.283885805668;14512.782308265385;14547.27263636814;14561;14615;10439.895601043892;10441.216908731723;10548.841767373495;10556.683299501028;10565.313254638577;16191.83808161927;16240.1067941262;16284.173219293456;16300.02199867988;16334.673306534041;6488.448481879093;6496.610203387811;6555.6066636002;6566.573172743756;6587.80236592903;795.8766391209372;834.5785378383998;879.2174964281794;902.566767951387;951.5622813505727;24642.99594415477;25749.613755793678;26019.869900650374;26089.217323480327;26166.215013549623;806.6007326373483;886.6763631274538;970.2916870684439;982.8771403574553;989.9259303655614;12266.448009839578;13966.231857247745;14086.788698169536;14135;14319.427222911176;309333;310559;310783;312314;312637;46638.067238655036;46820.5317946823;47120.7643961778;47278.527214727415;47344;1082.1505118481955;1107.413071072333;1111.777644471109;1133.7619099988929;1186.8162580851274;22936.311910642708;26613.334666633487;26960.056398025976;26972.730272697023;27195.320116997234;39991.80004100077;48419.27371089507;49084.509154907995;49127.75436122796;49288.60670899394;214974;222112;275550;276389;277180;35138;35659.46510802288;36456;36751.26497470089;36910;39678.801605991786;40034.59965400309;40057;40430.1913961725;40847.38728919009;33081.50377744384;33659.66340336565;34087.147821304665;34302.82848585741;34703.13242168865;33902.66097338995;34017.31965360729;34248.82875585606;34657.826710866284;35063;28915.7108428913;29272.41455170842;29545.85227073851;34490.48264276088;34701;23252.534949301258;30486.542701859045;30855.69144308528;34102.82948585241;34364;24159;24369.26892193237;24410.755892440848;24577;24740.876295618407 17:53:32 INFO - PROCESS | 2428 | |2;jquery.html;341.7385699939545;344.58821708058866;346.2970170553775;355.91991801844574;365.46276972849915;14505.347259373328;15696.073990372875;16171.757423638655;16231.350745970176;16304.043514778214;14768.261586920638;15613.843861561381;15910.363585456596;15911.522654320388;15912.602184945354;4760.571548560629;4797.880052998677;4918.114739346916;4930.630202734791;4936.210206366982;3494.755367124302;3722.1066943933397;4764.928526072112;4856.39295088114;5236;5496.697681627529;5496.835094947158;5497.065498865202;5498.3127109111365;5512.173174023888;5389.137737961946;5427.972860135714;5480.068388373966;5493.697846618435;5518.889622207534;4906.975465122651;4913.852584422473;4915.2872833439305;4916.754162291871;4919.631027672939;17524.649507009788;18292.817071829377;18356.54108647281;18483;18493.445196644123;1854.2212270846278;2270.421042634134;2409.4699166183414;2492.277239600514;2511.0960054380407;11903.642890713292;12012.639620811302;12078.69803254917;12491.063170262176;12699.301538415384;1650.9587260318467;1666.0919798709733;1669.2655231698013;1687.0974028894482;1721.9397321093827;54318.72840635772;54695;54924.725376372866;55009.449905501235;57199.42800572024;7937.801554961172;7939.64271607779;8103.878441823377;8230.547319897343;8313.41806073569;11284.943575282236;11473.311601303782;11496.94251528737;11529.596464123882;11575.826362604568;6677.165354330708;6745.908768281848;6768.830779230559;6849.315068493211;6866.622335771581;6685.899711504331;6717.764878229238;6801.081853949752;6816.693248803816;6823.215330236987;5329.413764485904;5429.131338985743;5442.428545002796;5447.863803404867;5511.669299842022;1526.6793973265517;1623.115402105855;1644.868410527155;1647.8846480746233;1658.6682663467354;754.4907187648315;838.4843321357322;859.072202021815;861.801785589318;944.9007854175212;14511.564653060213;14936.626584335478;15128.39486420553;15345.693086138437;15532.378704851906;850.7830503221638;868.4615538366253;897.7800438892513;906.2342320738965;922.0590656667619;8766.517841518651;9095.545222738836;9115.361924665342;9179;9267.907320926704;262576;285468;287280;287842;289798;41667.58332416637;63632.68183659052;63719.81400929935;66978.33021669721;67778;841.6885752271698;853.0914575976689;880.9603567839463;881.823635272948;881.8544940084814;10331.431771252353;12970.22178669283;13665.316734163052;13805.343358797008;14203.928980355033;27645.30886727848;28710.712892870804;29091.563626545194;29403.85298073496;29722.85138574293;36995;37341.626583733814;37708;37853.81073094617;38398.80800595979;6538.346165383614;6704.66476676174;6785;6786.0838786765125;7019.982102595197;8800.691975780817;9512.38169518979;9649.855252171083;9723.805523889625;9839.212862971088;8014.719484818003;8217.219364160395;8246.09292977784;8359.832803344021;8527.53098579584;8074.232947869943;8236.629351679068;8255.587220639065;8396.698511730692;8455.239028487465;7998.680052797823;8204.466709663853;8529.104444033288;8689.652413903374;8811.33914956368;5988.221531200916;6347.619142851444;6743.898841517479;6897.89653155193;6944.548604340702;7087.787366379017;8456.281216096455;8567.40028198045;8608.741737747878;8672.479651220947 17:53:32 INFO - PROCESS | 2428 | |3;mootools.html;1222.804351303791;1247.3513772838126;1281.7628738683345;1496.1771025935732;1501.6696326808099;5924.229850119484;6314.1475900753385;6315.242170939482;6318.778842740499;6318.968405157979;5369.40936496985;5549.472800083996;5850.21022162008;6037.637741735499;6200.937990620092;1801.2434777393526;1830.8626852986013;1831.423101722953;1832.6701193785113;1833.1384249402759;1820.7541981832414;1833.0010144471228;1836.3205613922867;1838.4484654603632;1852.9716007615768;1556.369670283537;1615.7010952973678;1753.7018706819872;1758.3494107180297;1813.455963211038;1787.177898166845;1791.2655811117509;1791.4625612316318;1791.6506281275156;1797.7213531902576;1738.41763009392;1755.1136675978676;1757.2882982392023;1760.9031503267315;1814.3740409558814;6072.2713274406915;6115.6942152892625;6122.693865306717;6128.846778830521;6149.692515374213;3621.3481573316794;3732.8880133596035;3734.178480734234;3734.477173195755;3736.065983504124;2194.4733264016522;2300.332903458012;2388;2389.0921449848947;2390.6653068570413;759.7416878261417;760.9353204977583;769.8037000564876;772.6677528662673;798.6086817459461;7847.607619618996;7912.327452166573;7946.920530794676;7956.960215198945;7970.242826931432;3221.5811944447073;3327.61732400777;3400.931981360359;3404.880829170967;3408.1138903885167;6129.448349648464;6294.464970477469;6361.777337793155;6758.695858686273;6772.559783614148;3740.8877733668032;3922.195949830335;3957.465742124776;3964.9008774780286;3965.246603145451;3529.94705079424;3585.0678823505555;3586.1751797086818;3587.192881601619;3591.712662987007;2719.904803331874;2815.099168266135;2851.4297140571966;2878.7409133177694;2977.449171903205;955.9713208603753;958.7603099225194;959.4962644611635;959.8577692545848;970.2286682087757;647.9578827376206;781.0861292288037;782.6517199846128;794.7218473534332;800.3517151107621;3945.053187235043;4008.8797336079965;4070.1249231414795;4102.548719640837;4158.6673066154635;764.0411283838747;769.3460558525209;774.8760198368346;820.1306614988132;824.4599787139433;2929.487339715541;2930.60436841028;2946.2634341414646;2974.1077676697337;3000.4599172149224;6961.40828029613;7234.059572255573;7301.1968683444775;7305.671244793997;7316.597587132653;6573.934260657332;6846.828829279308;6849.554778939353;7057.647117644097;7071.540349877241;5748.310202775694;5915.467607915309;5917.704114794157;5926.585139040226;5931.0213814720955;4271;4387.276099443556;4421.867343979686;4439.445069366329;4483.327500874764;6566.212054553484;6703.966480167763;6716.932830671826;6725.697343619451;6741.561798483083;6388.1376014237485;6611.702473388613;6910.997905303803;6969.33791289847;6977.2673869243;5255.421903590525;5344.144936810248;5366.597505187205;5373.9731301343245;5374.623776335776;5173.793048278027;5288.9471105289995;5456.809011684572;5610.4670056344585;5620.606557541097;5094.898102038012;5132.127538318569;5140.46025167367;5156.1750119980625;5160.09698302803;5123.974380128076;5183.144781111075;5222.686638801684;5229.058769421541;5242.344706911636;4669.906601868011;4736.763161841825;4750.168720473972;4753.382060332135;4754.500777418321;3549.503069570314;3556.3776339141064;3617.186133120027;3631.891043268706;3643.3806252936533;3590.6588874056924;3606.7655602386812;3644.4351125575577;3651.397519409374;3695.6489133532273 17:53:32 INFO - PROCESS | 2428 | |4;prototype.html;266.5894522435449;270.24466615808814;274.7650758601395;274.9738774816392;275.77799871103764;4507.391502147209;4536.727796332222;4551.158035763382;4565.539027511198;4570.885727856797;4482.753448560336;4486.259767138418;4508.684392092555;4512.5036246013;4513.706609070408;3336.8665253389895;3438.381091403559;3445.620981692012;3514.367413865516;3525.5593050868642;3498.317828023524;3518.8592456301844;3534.2754735279336;3541.185527328703;3549.165946002687;3505.948215535342;3527.435610302352;3532.5231093802263;3535.1515636247373;3537.5754909410907;3321.485169798673;3422.1957839907477;3431.6739909708785;3510.701590364822;3523.348180586574;3049.9172793658377;3057.1898446911587;3090.1193159949307;3091.613548306462;3097.6282846058393;4392.538783427758;4396.1427521633295;4396.780160991938;4412.691111622188;4439.489458712257;3681.5950245472977;3945.3884647879627;3959.6040395960463;3961.485006949078;3968.7817170055637;4620.838270660544;4622.722636641813;4635.0729854029;4649.651276154268;4655.022445286494;3263.2005158736024;3275.8853440129483;3276.524903888923;3277.4100661880852;3281.96718032819;4823.8422778532895;4824.807007719687;4855.757212139379;4855.955969466546;4869.537393947569;3251.544783730232;3290.753193510496;3296.7197788188273;3312.138843900603;3365.3269346130874;3301.636819949804;3331.284388539904;3335.533025376449;3339.480536356001;3358.143673363277;3871.651551360335;3874.341361968472;3875.5155605549307;3877.1470276539117;3880.0881792778673;4662.650301227353;4664.673472856867;4673.953260467351;4677.391939047902;4677.929831052537;1077.3105212663902;1108.4180805077237;1124.4714983957526;1126.8337270924553;1136.4090672850073;696.9616671083139;763.6907052643688;774.6630215856121;778.1634742651672;778.7118766056482;4191.937120943188;4354.238008348526;4489.7979590918485;4509.842155524541;4516.548345165523;4789.209780386267;4792.161371759928;4828.95171048285;4829.474483626902;4843.176659967814;4499.042916331407;4502.729836209838;4507.842225522091;4509;4510.458744950562;2380.4167978845294;2443.315871555967;2460.3234110619724;2468.6543883856275;2474.6411770293566;4684.063187362541;4691.9530804692195;4698.459677137104;4716.504766999485;4726.976365118152;4693.647976401783;4709.576138147583;4709.693869898514;4713.552212539803;4728.834490792806;4507.414036175342;4640.559146881041;4641.234196357698;4660.300954856731;4664.743439110882;4614.307853821953;4626.537346265347;4638.373819534319;4648.535146485325;4654.650901182357;4525.253333199985;4554.817807287804;4562.1560011398;4575.908481830278;4576.176288268143;4439.267520859022;4622.052479241815;4660.254359302496;4674.22875225584;4698.201305778094;3229.3056992746674;3231.369882872911;3238.9149634871637;3240.1737556922835;3241.918952026218;4447.911041779082;4555.840545580889;4567.725936443824;4588.623412976161;4609.3777340060005;4221.072757184558;4456.844010459618;4475.4489940733465;4510.2783554631105;4513.059384464712;4445.711028783118;4495.730256184639;4499.977500112478;4507.864764057083;4508.887277818081;4465.575770301816;4483.932741008823;4490.326451032241;4494.528074552256;4497.437820272466;4404.757738324295;4517.322401639781;4521.36700861873;4521.773911304487;4529.32060190974;4563.726176429424;4608.838690645811;4612.79242434098;4623.745693986863;4631.722096674211 17:53:32 INFO - PROCESS | 2428 | |5;yui.html;591.7425919724917;623.2147494157362;705.2298730187232;720.9531380460271;737.9707294786036;10840.620578279762;11349.319040857545;11420.257683250593;11573.36346500942;11590.652280431601;10281.280310378257;10300.948495257513;10317.380957142557;10329.535170917308;10332.793344133132;741.295769019431;757.1898069066101;757.2768006553728;757.7537300377372;760.6348952502802;607.2925042325685;623.4918541388777;736.5691070723607;760.8136006678371;768.1013214538975;784.6782819044194;784.8194915169514;787.0201599009241;787.2363807107097;793.5159552672894;632.4560877645222;767.8924950506905;773.6943907156669;777.5179388778937;778.1518145221679;484.91756401411845;559.9244102046213;574.6121368076573;577.6216578141324;580.4108829538022;11525.942370288094;11583.18917675763;11601.76796464066;11611.07111431092;11618.593349232737;10052.748681282954;10364.792704145875;10746.408947507884;10783.352998820095;10986.890131098666;9358.204552613037;9366.859497107549;9419;9529.666461673878;9648;3674.430463278196;3680.411134218512;3681.3189559931498;3757.830897609614;3787.715921305913;41033.38449923253;41639.583604163876;42849.35725964082;42886;43285.35071973923;8641.524716140548;8678.305735541142;8712.651493940299;8844.911550884537;8862.556872156367;16574.585635359213;16708.164591770364;16986.915065424593;17093.401730939357;17103.14484275781;5990.101484777319;6068.878622427526;6077.665728384893;6167.444929956326;6294.464970477469;3257.250832308535;3297.4394352960053;3419.4357930941615;3422.4524076148195;3458.9654103459147;2111.429913923232;2174.4563859035243;2174.934751957444;2176.6734989751662;2180.858244214121;377.6280363841669;385.3833865814674;387.6840375094289;388.896942310288;391.3933403225047;475.32741171242304;545.9808906688247;549.4395716369361;572.6850232372178;577.719805894141;6459.160309159779;6574.408303252634;6676.6661666917435;6833.658317084126;6900.758473453405;460.2520903531761;473.31842147307765;509.66362200947196;515.7034705044539;525.324957429701;2492.7756501914914;2935.163478408643;2936.265933516621;2972.4946759051013;3123.234807472184;57346.7132664334;58394.70802645959;59728.70135649294;60256.69871650614;60324;48354.516454835706;51444.22833657498;52285.2157217642;53008.73495632497;53909.46090539123;47995.52004479981;48329.75835120802;48568.5143148564;49718.50281497283;50012.74993625009;5669.433056694463;5782.681952492485;5838.94161058401;5919.319278283053;6093.086037094471;30535.389292214477;31866.522002170448;32444.67555324511;32502;34034;39406;40088.1982360357;40454;41738.373924391766;42624.36063458989;9078.954605227196;9482.431054136774;9644.132028117503;10145.898541014496;10147.594096236067;10481.161507079263;10528.473576321307;10551.525181367011;11005.724856878642;11483.770324593628;9859.408435493893;9875.851862222216;9927.354721943051;9935.105840474393;9977.20182385393;10131.240156988108;10151.492425378554;10239.078482936571;10377.686237530279;10381.844272336071;7506.324430801035;7551.546907185587;7574.621268936641;7651.081870175614;7907.209279072047;8252.628631711708;8436.451630644235;8475.237228649452;8570.271526920282;8843.734687959372;8526.747666144749;8646.956765216133;8691.26124279418;8795;8815.647374104963 17:53:32 INFO - PROCESS | 2428 | __end_tp_report 17:53:32 INFO - PROCESS | 2428 | __start_cc_report 17:53:32 INFO - PROCESS | 2428 | _x_x_mozilla_cycle_collect,1363 17:53:32 INFO - PROCESS | 2428 | __end_cc_report 17:53:32 INFO - PROCESS | 2428 | __startTimestamp1479779612381__endTimestamp 17:53:32 INFO - PROCESS | 2428 | 17:53:32 INFO - PROCESS | 2428 | ------- Summary: start ------- 17:53:32 INFO - PROCESS | 2428 | Number of tests: 6 17:53:32 INFO - PROCESS | 2428 | 17:53:32 INFO - PROCESS | 2428 | [#0] dojo.html Cycles:165 Average:4317.14 Median:4480.60 stddev:501.20 (11.2%) stddev-sans-first:485.64 17:53:32 INFO - PROCESS | 2428 | Values: 2663.0 2685.8 2712.2 2717.9 2728.1 4420.8 4437.1 4469.2 4486.8 4520.3 4322.4 4376.2 4436.6 4437.8 4467.1 4060.4 4066.3 4067.4 4076.4 4109.7 4085.6 4090.3 4114.9 4122.5 4130.8 4067.3 4096.8 4106.7 4120.0 4120.6 4088.5 4105.9 4151.5 4166.0 4173.9 3758.8 4106.9 4107.2 4138.5 4140.6 4166.9 4177.1 4279.0 4355.1 4362.5 4590.4 4590.5 4642.3 4643.4 4643.6 4600.6 4614.3 4675.7 4682.8 4728.1 4243.3 4287.4 4334.3 4344.8 4390.4 4787.9 4788.0 4792.1 4793.9 4842.2 4414.8 4543.2 4608.3 4621.3 4667.6 4508.4 4530.6 4656.9 4707.7 4709.0 4630.8 4656.8 4658.5 4694.7 4697.7 4635.5 4649.5 4651.8 4693.8 4699.4 3087.0 3137.5 3142.7 3157.4 3194.9 2921.0 2971.5 2986.3 2992.7 3012.5 4333.1 4343.4 4351.1 4354.7 4375.7 4613.8 4678.3 4682.8 4690.8 4699.9 4172.1 4189.5 4238.0 4268.4 4346.5 3830.4 3841.8 3854.0 3863.5 3867.0 4636.9 4641.8 4642.1 4644.4 4657.5 4536.0 4565.2 4581.5 4645.6 4700.9 4784.7 4824.3 4826.4 4834.3 4837.2 4642.7 4653.2 4665.0 4666.6 4707.3 4549.1 4698.3 4704.8 4711.1 4715.9 4480.6 4506.9 4525.2 4552.9 4618.2 4532.7 4570.4 4579.2 4582.5 4607.4 4512.0 4514.8 4518.1 4518.6 4558.7 4434.6 4440.8 4476.5 4490.8 4523.2 4413.0 4458.0 4460.9 4461.4 4471.6 17:53:32 INFO - PROCESS | 2428 | 17:53:32 INFO - PROCESS | 2428 | [#1] ext.html Cycles:180 Average:40354.38 Median:34574.15 stddev:67104.38 (194.1%) stddev-sans-first:67226.10 17:53:32 INFO - PROCESS | 2428 | Values: 559.3 564.4 587.2 587.8 596.2 25913.4 37968.8 39081.0 39173.8 39188.6 34937.3 35090.1 35503.8 35515.8 35532.8 7529.1 7637.2 7651.0 7668.6 7681.2 7645.4 7702.2 7726.8 7727.9 7736.0 7754.5 7760.1 7790.8 7792.7 7797.5 7711.3 7760.6 7762.9 7772.8 7800.1 7627.9 7701.3 7702.3 7705.6 7710.6 33714.4 33849.3 34072.1 34092.5 34137.8 2866.1 2898.6 2984.0 2992.8 3085.9 25899.0 26083.6 26370.5 26452.7 26489.7 3557.8 3596.0 3646.9 3669.8 3674.7 187588.0 187797.0 188940.1 188974.0 189284.0 46138.0 46241.0 46530.3 46621.3 46638.0 29694.3 29711.4 29806.4 32461.5 48799.3 14322.3 14512.8 14547.3 14561.0 14615.0 10439.9 10441.2 10548.8 10556.7 10565.3 16191.8 16240.1 16284.2 16300.0 16334.7 6488.4 6496.6 6555.6 6566.6 6587.8 795.9 834.6 879.2 902.6 951.6 24643.0 25749.6 26019.9 26089.2 26166.2 806.6 886.7 970.3 982.9 989.9 12266.4 13966.2 14086.8 14135.0 14319.4 309333.0 310559.0 310783.0 312314.0 312637.0 46638.1 46820.5 47120.8 47278.5 47344.0 1082.2 1107.4 1111.8 1133.8 1186.8 22936.3 26613.3 26960.1 26972.7 27195.3 39991.8 48419.3 49084.5 49127.8 49288.6 214974.0 222112.0 275550.0 276389.0 277180.0 35138.0 35659.5 36456.0 36751.3 36910.0 39678.8 40034.6 40057.0 40430.2 40847.4 33081.5 33659.7 34087.1 34302.8 34703.1 33902.7 34017.3 34248.8 34657.8 35063.0 28915.7 29272.4 29545.9 34490.5 34701.0 23252.5 30486.5 30855.7 34102.8 34364.0 24159.0 24369.3 24410.8 24577.0 24740.9 17:53:32 INFO - PROCESS | 2428 | 17:53:32 INFO - PROCESS | 2428 | [#2] jquery.html Cycles:180 Average:19239.44 Median:29880.58 stddev:46707.51 (156.3%) stddev-sans-first:46816.98 17:53:32 INFO - PROCESS | 2428 | Values: 341.7 344.6 346.3 355.9 365.5 14505.3 15696.1 16171.8 16231.4 16304.0 14768.3 15613.8 15910.4 15911.5 15912.6 4760.6 4797.9 4918.1 4930.6 4936.2 3494.8 3722.1 4764.9 4856.4 5236.0 5496.7 5496.8 5497.1 5498.3 5512.2 5389.1 5428.0 5480.1 5493.7 5518.9 4907.0 4913.9 4915.3 4916.8 4919.6 17524.6 18292.8 18356.5 18483.0 18493.4 1854.2 2270.4 2409.5 2492.3 2511.1 11903.6 12012.6 12078.7 12491.1 12699.3 1651.0 1666.1 1669.3 1687.1 1721.9 54318.7 54695.0 54924.7 55009.4 57199.4 7937.8 7939.6 8103.9 8230.5 8313.4 11284.9 11473.3 11496.9 11529.6 11575.8 6677.2 6745.9 6768.8 6849.3 6866.6 6685.9 6717.8 6801.1 6816.7 6823.2 5329.4 5429.1 5442.4 5447.9 5511.7 1526.7 1623.1 1644.9 1647.9 1658.7 754.5 838.5 859.1 861.8 944.9 14511.6 14936.6 15128.4 15345.7 15532.4 850.8 868.5 897.8 906.2 922.1 8766.5 9095.5 9115.4 9179.0 9267.9 262576.0 285468.0 287280.0 287842.0 289798.0 41667.6 63632.7 63719.8 66978.3 67778.0 841.7 853.1 881.0 881.8 881.9 10331.4 12970.2 13665.3 13805.3 14203.9 27645.3 28710.7 29091.6 29403.9 29722.9 36995.0 37341.6 37708.0 37853.8 38398.8 6538.3 6704.7 6785.0 6786.1 7020.0 8800.7 9512.4 9649.9 9723.8 9839.2 8014.7 8217.2 8246.1 8359.8 8527.5 8074.2 8236.6 8255.6 8396.7 8455.2 7998.7 8204.5 8529.1 8689.7 8811.3 5988.2 6347.6 6743.9 6897.9 6944.5 7087.8 8456.3 8567.4 8608.7 8672.5 17:53:32 INFO - PROCESS | 2428 | 17:53:32 INFO - PROCESS | 2428 | [#3] mootools.html Cycles:180 Average:3993.93 Median:5109.44 stddev:2096.20 (41.0%) stddev-sans-first:2091.74 17:53:32 INFO - PROCESS | 2428 | Values: 1222.8 1247.4 1281.8 1496.2 1501.7 5924.2 6314.1 6315.2 6318.8 6319.0 5369.4 5549.5 5850.2 6037.6 6200.9 1801.2 1830.9 1831.4 1832.7 1833.1 1820.8 1833.0 1836.3 1838.4 1853.0 1556.4 1615.7 1753.7 1758.3 1813.5 1787.2 1791.3 1791.5 1791.7 1797.7 1738.4 1755.1 1757.3 1760.9 1814.4 6072.3 6115.7 6122.7 6128.8 6149.7 3621.3 3732.9 3734.2 3734.5 3736.1 2194.5 2300.3 2388.0 2389.1 2390.7 759.7 760.9 769.8 772.7 798.6 7847.6 7912.3 7946.9 7957.0 7970.2 3221.6 3327.6 3400.9 3404.9 3408.1 6129.4 6294.5 6361.8 6758.7 6772.6 3740.9 3922.2 3957.5 3964.9 3965.2 3529.9 3585.1 3586.2 3587.2 3591.7 2719.9 2815.1 2851.4 2878.7 2977.4 956.0 958.8 959.5 959.9 970.2 648.0 781.1 782.7 794.7 800.4 3945.1 4008.9 4070.1 4102.5 4158.7 764.0 769.3 774.9 820.1 824.5 2929.5 2930.6 2946.3 2974.1 3000.5 6961.4 7234.1 7301.2 7305.7 7316.6 6573.9 6846.8 6849.6 7057.6 7071.5 5748.3 5915.5 5917.7 5926.6 5931.0 4271.0 4387.3 4421.9 4439.4 4483.3 6566.2 6704.0 6716.9 6725.7 6741.6 6388.1 6611.7 6911.0 6969.3 6977.3 5255.4 5344.1 5366.6 5374.0 5374.6 5173.8 5288.9 5456.8 5610.5 5620.6 5094.9 5132.1 5140.5 5156.2 5160.1 5124.0 5183.1 5222.7 5229.1 5242.3 4669.9 4736.8 4750.2 4753.4 4754.5 3549.5 3556.4 3617.2 3631.9 3643.4 3590.7 3606.8 3644.4 3651.4 3695.6 17:53:32 INFO - PROCESS | 2428 | 17:53:32 INFO - PROCESS | 2428 | [#4] prototype.html Cycles:180 Average:3855.97 Median:4495.13 stddev:1132.41 (25.2%) stddev-sans-first:1103.07 17:53:32 INFO - PROCESS | 2428 | Values: 266.6 270.2 274.8 275.0 275.8 4507.4 4536.7 4551.2 4565.5 4570.9 4482.8 4486.3 4508.7 4512.5 4513.7 3336.9 3438.4 3445.6 3514.4 3525.6 3498.3 3518.9 3534.3 3541.2 3549.2 3505.9 3527.4 3532.5 3535.2 3537.6 3321.5 3422.2 3431.7 3510.7 3523.3 3049.9 3057.2 3090.1 3091.6 3097.6 4392.5 4396.1 4396.8 4412.7 4439.5 3681.6 3945.4 3959.6 3961.5 3968.8 4620.8 4622.7 4635.1 4649.7 4655.0 3263.2 3275.9 3276.5 3277.4 3282.0 4823.8 4824.8 4855.8 4856.0 4869.5 3251.5 3290.8 3296.7 3312.1 3365.3 3301.6 3331.3 3335.5 3339.5 3358.1 3871.7 3874.3 3875.5 3877.1 3880.1 4662.7 4664.7 4674.0 4677.4 4677.9 1077.3 1108.4 1124.5 1126.8 1136.4 697.0 763.7 774.7 778.2 778.7 4191.9 4354.2 4489.8 4509.8 4516.5 4789.2 4792.2 4829.0 4829.5 4843.2 4499.0 4502.7 4507.8 4509.0 4510.5 2380.4 2443.3 2460.3 2468.7 2474.6 4684.1 4692.0 4698.5 4716.5 4727.0 4693.6 4709.6 4709.7 4713.6 4728.8 4507.4 4640.6 4641.2 4660.3 4664.7 4614.3 4626.5 4638.4 4648.5 4654.7 4525.3 4554.8 4562.2 4575.9 4576.2 4439.3 4622.1 4660.3 4674.2 4698.2 3229.3 3231.4 3238.9 3240.2 3241.9 4447.9 4555.8 4567.7 4588.6 4609.4 4221.1 4456.8 4475.4 4510.3 4513.1 4445.7 4495.7 4500.0 4507.9 4508.9 4465.6 4483.9 4490.3 4494.5 4497.4 4404.8 4517.3 4521.4 4521.8 4529.3 4563.7 4608.8 4612.8 4623.7 4631.7 17:53:32 INFO - PROCESS | 2428 | 17:53:32 INFO - PROCESS | 2428 | [#5] yui.html Cycles:180 Average:12676.37 Median:26405.27 stddev:15876.81 (60.1%) stddev-sans-first:15895.41 17:53:32 INFO - PROCESS | 2428 | Values: 591.7 623.2 705.2 721.0 738.0 10840.6 11349.3 11420.3 11573.4 11590.7 10281.3 10300.9 10317.4 10329.5 10332.8 741.3 757.2 757.3 757.8 760.6 607.3 623.5 736.6 760.8 768.1 784.7 784.8 787.0 787.2 793.5 632.5 767.9 773.7 777.5 778.2 484.9 559.9 574.6 577.6 580.4 11525.9 11583.2 11601.8 11611.1 11618.6 10052.7 10364.8 10746.4 10783.4 10986.9 9358.2 9366.9 9419.0 9529.7 9648.0 3674.4 3680.4 3681.3 3757.8 3787.7 41033.4 41639.6 42849.4 42886.0 43285.4 8641.5 8678.3 8712.7 8844.9 8862.6 16574.6 16708.2 16986.9 17093.4 17103.1 5990.1 6068.9 6077.7 6167.4 6294.5 3257.3 3297.4 3419.4 3422.5 3459.0 2111.4 2174.5 2174.9 2176.7 2180.9 377.6 385.4 387.7 388.9 391.4 475.3 546.0 549.4 572.7 577.7 6459.2 6574.4 6676.7 6833.7 6900.8 460.3 473.3 509.7 515.7 525.3 2492.8 2935.2 2936.3 2972.5 3123.2 57346.7 58394.7 59728.7 60256.7 60324.0 48354.5 51444.2 52285.2 53008.7 53909.5 47995.5 48329.8 48568.5 49718.5 50012.7 5669.4 5782.7 5838.9 5919.3 6093.1 30535.4 31866.5 32444.7 32502.0 34034.0 39406.0 40088.2 40454.0 41738.4 42624.4 9079.0 9482.4 9644.1 10145.9 10147.6 10481.2 10528.5 10551.5 11005.7 11483.8 9859.4 9875.9 9927.4 9935.1 9977.2 10131.2 10151.5 10239.1 10377.7 10381.8 7506.3 7551.5 7574.6 7651.1 7907.2 8252.6 8436.5 8475.2 8570.3 8843.7 8526.7 8647.0 8691.3 8795.0 8815.6 17:53:32 INFO - PROCESS | 2428 | -------- Summary: end -------- 17:53:32 INFO - PROCESS | 2428 | 17:53:33 INFO - TEST-INFO | 2428: exit 0 17:53:33 INFO - TEST-OK | dromaeo_css | took 1125955ms 17:53:33 INFO - TEST-START | kraken 17:53:33 INFO - operating with platform_type : w8_ 17:53:33 INFO - Initialising browser for kraken test... 17:53:33 INFO - TEST-INFO | started process 3056 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpzwxwex\profile http://localhost:49274/getInfo.html) 17:53:39 INFO - PROCESS | 3056 | __metrics Screen width/height:1600/1200 17:53:39 INFO - PROCESS | 3056 | colorDepth:24 17:53:39 INFO - PROCESS | 3056 | Browser inner width/height: 1010/674 17:53:39 INFO - PROCESS | 3056 | __metrics 17:53:40 INFO - PROCESS | 3056 | 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" 17:53:40 INFO - PROCESS | 3056 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:53:41 INFO - PROCESS | 3056 | console.error: 17:53:41 INFO - PROCESS | 3056 | Message: Error: Connection closed before committing the transaction. 17:53:41 INFO - PROCESS | 3056 | Stack: 17:53:41 INFO - PROCESS | 3056 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:932:23 17:53:41 INFO - PROCESS | 3056 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 17:53:41 INFO - PROCESS | 3056 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 17:53:41 INFO - PROCESS | 3056 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 17:53:41 INFO - PROCESS | 3056 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 17:53:41 INFO - PROCESS | 3056 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 17:53:41 INFO - PROCESS | 3056 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:550:9 17:53:41 INFO - PROCESS | 3056 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 17:53:41 INFO - PROCESS | 3056 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:386:5 17:53:41 INFO - PROCESS | 3056 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 17:53:41 INFO - PROCESS | 3056 | Barrier/this.client.addBlocker/promise13.4% 17:54:40 INFO - TinderboxPrint: I/O read bytes / time
225,960,448 / 2,202,850 17:54:40 INFO - TinderboxPrint: I/O write bytes / time
416,484,864 / 3,256,340 17:54:40 INFO - TinderboxPrint: CPU idle
8,282.2 (86.6%) 17:54:40 INFO - TinderboxPrint: CPU user
1,235.9 (12.9%) 17:54:40 INFO - install - Wall time: 3s; CPU: 12.0%; Read bytes: 0; Write bytes: 34466816; Read time: 0; Write time: 70310 17:54:40 INFO - run-tests - Wall time: 1194s; CPU: 13.0%; Read bytes: 225960448; Write bytes: 322742272; Read time: 2202850; Write time: 3125240 17:54:41 INFO - Running post-run listener: _upload_blobber_files 17:54:41 INFO - Blob upload gear active. 17:54:41 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 17:54:41 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 17:54:41 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'] 17:54:41 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 17:54:41 INFO - (blobuploader) - INFO - Open directory for files ... 17:54:41 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 17:54:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:54:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:42 INFO - (blobuploader) - INFO - Done attempting. 17:54:42 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 17:54:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:54:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:44 INFO - (blobuploader) - INFO - Done attempting. 17:54:44 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 17:54:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:54:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:46 INFO - (blobuploader) - INFO - Done attempting. 17:54:46 INFO - (blobuploader) - INFO - Iteration through files over. 17:54:46 INFO - Return code: 0 17:54:46 INFO - rmtree: C:\slave\test\build\uploaded_files.json 17:54:46 INFO - Using _rmtree_windows ... 17:54:46 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 17:54:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5336d6783e9a0c77cd52e40159ec7fa5608dd380f5f8df0396ac78e5785f495caf3582e1450b9f8d8ad8db035d6fd0bb1ae24200d88d3e7cf1ca7dc39a8d017d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/377d0d79faf39b70c1671e8eb90ce4b47f9ec1a6366fd5961bd90d651f4644a65eff3f433212539d330b4e2c058187bb921bbe49f8051782b8d4391a055ba72b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b4f6230fce734fe8e009a4a6cbeed829ad3c8cbcf48e07cd7d847f00f2c807f4e0501275c79d5e4b37dc64455cba1add354b9060900548898661d4595f89e68c"} 17:54:46 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 17:54:46 INFO - Writing to file C:\slave\test\properties\blobber_files 17:54:46 INFO - Contents: 17:54:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5336d6783e9a0c77cd52e40159ec7fa5608dd380f5f8df0396ac78e5785f495caf3582e1450b9f8d8ad8db035d6fd0bb1ae24200d88d3e7cf1ca7dc39a8d017d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/377d0d79faf39b70c1671e8eb90ce4b47f9ec1a6366fd5961bd90d651f4644a65eff3f433212539d330b4e2c058187bb921bbe49f8051782b8d4391a055ba72b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b4f6230fce734fe8e009a4a6cbeed829ad3c8cbcf48e07cd7d847f00f2c807f4e0501275c79d5e4b37dc64455cba1add354b9060900548898661d4595f89e68c"} 17:54:46 INFO - Running post-run listener: copy_logs_to_upload_dir 17:54:46 INFO - Copying logs to upload dir... 17:54:46 INFO - mkdir: C:\slave\test\build\upload\logs 17:54:46 INFO - Copying logs to upload dir... 17:54:46 INFO - Using _rmtree_windows ... 17:54:46 INFO - Using _rmtree_windows ... 17:54:46 INFO - Using _rmtree_windows ... 17:54:46 INFO - Using _rmtree_windows ... 17:54:46 INFO - Using _rmtree_windows ... 17:54:46 INFO - Using _rmtree_windows ... 17:54:46 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1394.882000 ========= master_lag: -0.13 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 14 secs) (at 2016-11-21 17:54:46.316175) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 17:54:46.316962) ========= '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-098\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-098 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-098 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-098\AppData\Local LOGONSERVER=\\T-W864-IX-098 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-098 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-098 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-098 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/5336d6783e9a0c77cd52e40159ec7fa5608dd380f5f8df0396ac78e5785f495caf3582e1450b9f8d8ad8db035d6fd0bb1ae24200d88d3e7cf1ca7dc39a8d017d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/377d0d79faf39b70c1671e8eb90ce4b47f9ec1a6366fd5961bd90d651f4644a65eff3f433212539d330b4e2c058187bb921bbe49f8051782b8d4391a055ba72b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b4f6230fce734fe8e009a4a6cbeed829ad3c8cbcf48e07cd7d847f00f2c807f4e0501275c79d5e4b37dc64455cba1add354b9060900548898661d4595f89e68c"} build_url:https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/ToR4M0Z5TqyDZmXqH1SBjA/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/5336d6783e9a0c77cd52e40159ec7fa5608dd380f5f8df0396ac78e5785f495caf3582e1450b9f8d8ad8db035d6fd0bb1ae24200d88d3e7cf1ca7dc39a8d017d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/377d0d79faf39b70c1671e8eb90ce4b47f9ec1a6366fd5961bd90d651f4644a65eff3f433212539d330b4e2c058187bb921bbe49f8051782b8d4391a055ba72b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b4f6230fce734fe8e009a4a6cbeed829ad3c8cbcf48e07cd7d847f00f2c807f4e0501275c79d5e4b37dc64455cba1add354b9060900548898661d4595f89e68c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 17:54:46.441735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 17:54:46.442073) ========= '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-098\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-098 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-098 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-098\AppData\Local LOGONSERVER=\\T-W864-IX-098 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-098 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-098 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-098 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-21 17:54:46.564560) ========= ========= Started reboot slave lost (results: 0, elapsed: 1 secs) (at 2016-11-21 17:54:46.564896) ========= ========= Finished reboot slave lost (results: 0, elapsed: 1 secs) (at 2016-11-21 17:54:47.664745) ========= ========= Total master_lag: 0.09 =========