builder: mozilla-central_win8_64_test-dromaeojs-pgo slave: t-w864-ix-098 starttime: 1477143526.88 results: success (0) buildid: 20161022030204 builduid: 07445e3160354a56b7e3a05d2eb69015 revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 06:38:46.876724) ========= master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 06:38:46.877151) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 06:38:46.877428) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 06:38:47.117551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 06:38:47.117808) ========= '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 --06:38:47-- 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% 17.87 MB/s 06:38:48 (17.87 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.000000 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 06:38:48.164088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-22 06:38:48.164421) ========= '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=2.507000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-22 06:38:50.694389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-22 06:38:50.694757) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev 5639a9f476d08f300c079117e61697f5026b6367 --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5639a9f476d08f300c079117e61697f5026b6367 --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-10-22 06:38:51,032 truncating revision to first 12 chars 2016-10-22 06:38:51,032 Setting DEBUG logging. 2016-10-22 06:38:51,032 attempt 1/10 2016-10-22 06:38:51,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5639a9f476d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-22 06:38:52,374 unpacking tar archive at: mozilla-central-5639a9f476d0/testing/mozharness/ 2016-10-22 06:38:52,522 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=2.173000 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-22 06:38:52.931967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 06:38:52.932329) ========= script_repo_revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 06:38:52.932841) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 06:38:52.933182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 06:38:52.976360) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 59 secs) (at 2016-10-22 06:38:52.976903) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Firefox' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Firefox' 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', 'Firefox', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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 06:38:53 INFO - MultiFileLogger online at 20161022 06:38:53 in C:\slave\test 06:38:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:38:53 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 06:38:53 INFO - {'append_to_log': False, 06:38:53 INFO - 'base_work_dir': 'C:\\slave\\test', 06:38:53 INFO - 'blob_upload_branch': 'Firefox', 06:38:53 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 06:38:53 INFO - 'branch': 'Firefox', 06:38:53 INFO - 'buildbot_json_path': 'buildprops.json', 06:38:53 INFO - 'config_files': ('talos/windows_config.py',), 06:38:53 INFO - 'default_actions': ('clobber', 06:38:53 INFO - 'read-buildbot-config', 06:38:53 INFO - 'download-and-extract', 06:38:53 INFO - 'populate-webroot', 06:38:53 INFO - 'create-virtualenv', 06:38:53 INFO - 'install', 06:38:53 INFO - 'run-tests'), 06:38:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:38:53 INFO - 'download_minidump_stackwalk': True, 06:38:53 INFO - 'download_symbols': 'ondemand', 06:38:53 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 06:38:53 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 06:38:53 INFO - 'hg': 'c:/mozilla-build/hg/hg', 06:38:53 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 06:38:53 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 06:38:53 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 06:38:53 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 06:38:53 INFO - 'C:/mozilla-build/tooltool.py'), 06:38:53 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 06:38:53 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 06:38:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:38:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:38:53 INFO - 'installer_path': 'installer.exe', 06:38:53 INFO - 'log_level': 'info', 06:38:53 INFO - 'log_name': 'talos', 06:38:53 INFO - 'log_to_console': True, 06:38:53 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 06:38:53 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 06:38:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 06:38:53 INFO - 'opt_config_files': (), 06:38:53 INFO - 'pip_index': False, 06:38:53 INFO - 'sps_profile': False, 06:38:53 INFO - 'sps_profile_interval': 0, 06:38:53 INFO - 'suite': 'dromaeojs', 06:38:53 INFO - 'system_bits': '32', 06:38:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:38:53 INFO - 'title': 'T-W864-IX-098', 06:38:53 INFO - 'use_talos_json': True, 06:38:53 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 06:38:53 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 06:38:53 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 06:38:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:38:53 INFO - 'work_dir': 'build'} 06:38:53 INFO - [mozharness: 2016-10-22 13:38:53.491000Z] Running clobber step. 06:38:53 INFO - Running pre-action listener: _resource_record_pre_action 06:38:53 INFO - Running main action method: clobber 06:38:53 INFO - rmtree: C:\slave\test\build 06:38:53 INFO - Using _rmtree_windows ... 06:38:53 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 06:40:23 INFO - Running post-action listener: _resource_record_post_action 06:40:23 INFO - [mozharness: 2016-10-22 13:40:23.339000Z] Finished clobber step (success) 06:40:23 INFO - [mozharness: 2016-10-22 13:40:23.340000Z] Running read-buildbot-config step. 06:40:23 INFO - Running pre-action listener: _resource_record_pre_action 06:40:23 INFO - Running main action method: read_buildbot_config 06:40:23 INFO - Using buildbot properties: 06:40:23 INFO - { 06:40:23 INFO - "project": "", 06:40:23 INFO - "product": "firefox", 06:40:23 INFO - "script_repo_revision": "production", 06:40:23 INFO - "builddir": "mozilla-central_win8_64_test-dromaeojs", 06:40:23 INFO - "repository": "", 06:40:23 INFO - "buildername": "Windows 8 64-bit mozilla-central pgo talos dromaeojs", 06:40:23 INFO - "buildid": "20161022030204", 06:40:23 INFO - "stage_platform": "win64-pgo", 06:40:23 INFO - "basedir": "C:\\slave\\test", 06:40:23 INFO - "nightly_build": "True", 06:40:23 INFO - "buildnumber": 81, 06:40:23 INFO - "slavename": "t-w864-ix-098", 06:40:23 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/", 06:40:23 INFO - "platform": "win8_64", 06:40:23 INFO - "scheduler": "tests-mozilla-central-win64-pgo-talos", 06:40:23 INFO - "branch": "mozilla-central", 06:40:23 INFO - "repo_path": "mozilla-central", 06:40:23 INFO - "revision": "5639a9f476d08f300c079117e61697f5026b6367", 06:40:23 INFO - "pgo_build": "True", 06:40:23 INFO - "builduid": "07445e3160354a56b7e3a05d2eb69015", 06:40:23 INFO - "slavebuilddir": "test" 06:40:23 INFO - } 06:40:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 06:40:23 INFO - Running post-action listener: _resource_record_post_action 06:40:23 INFO - [mozharness: 2016-10-22 13:40:23.343000Z] Finished read-buildbot-config step (success) 06:40:23 INFO - [mozharness: 2016-10-22 13:40:23.343000Z] Running download-and-extract step. 06:40:23 INFO - Running pre-action listener: _resource_record_pre_action 06:40:23 INFO - Running main action method: download_and_extract 06:40:23 INFO - mkdir: C:\slave\test\build\tests 06:40:23 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')]} 06:40:23 INFO - trying https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 06:40:23 INFO - Downloading https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 06:40:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.test_packages.json'}, attempt #1 06:40:24 INFO - Downloaded 1218 bytes. 06:40:24 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 06:40:24 INFO - Using the following test package requirements: 06:40:24 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 06:40:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:40:24 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 06:40:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 06:40:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:40:24 INFO - u'jsshell-win64.zip'], 06:40:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:40:24 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 06:40:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 06:40:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:40:24 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 06:40:24 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:40:24 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 06:40:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:40:24 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 06:40:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:40:24 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 06:40:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 06:40:24 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 06:40:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 06:40:24 INFO - Fetch https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 06:40:24 INFO - Http code: 200 06:40:24 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 06:40:24 INFO - x-amz-cf-id: z64Xx7Pvt9JgSI-o7Hly_LERi_GjcDaw1g94XwgLumQK79Kv8n_wBQ== 06:40:24 INFO - x-amz-version-id: hi2R78RMOuYhwMlYjkCQiANEtYfpoK4F 06:40:25 INFO - Expected file size: 17462497 06:40:25 INFO - Obtained file size: 17462497 06:40:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip', u'firefox-52.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 06:40:46 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 06:40:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 06:40:46 INFO - Fetch https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 06:40:47 INFO - Http code: 200 06:40:47 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 06:40:47 INFO - x-amz-cf-id: VOn-Q3PJWxhn6_ndcuH8F6GPuPRy3p8e2J9RcwR8MhSJ_mzhVnH74Q== 06:40:47 INFO - x-amz-version-id: hi2R78RMOuYhwMlYjkCQiANEtYfpoK4F 06:40:47 INFO - Expected file size: 17462497 06:40:47 INFO - Obtained file size: 17462497 06:40:59 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 06:40:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 06:40:59 INFO - Fetch https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 06:40:59 INFO - Http code: 200 06:40:59 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 06:40:59 INFO - x-amz-cf-id: J_a6rSk345TsPgnI6m94Lvg3p35Bxsr9DvSNL2zDkaQiaeaDiECYPw== 06:40:59 INFO - x-amz-version-id: A1rDWkH3Yr49MhU3lYNOZOis5EntUcWl 06:40:59 INFO - Expected file size: 14409028 06:40:59 INFO - Obtained file size: 14409028 06:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:02 INFO - trying https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 06:41:02 INFO - Downloading https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 06:41:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip'}, attempt #1 06:41:03 INFO - Downloaded 57274210 bytes. 06:41:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 06:41:03 INFO - mkdir: C:\slave\test\properties 06:41:03 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 06:41:03 INFO - Writing to file C:\slave\test\properties\build_url 06:41:03 INFO - Contents: 06:41:03 INFO - build_url:https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 06:41:04 INFO - Running post-action listener: _resource_record_post_action 06:41:04 INFO - Running post-action listener: set_extra_try_arguments 06:41:04 INFO - [mozharness: 2016-10-22 13:41:04.242000Z] Finished download-and-extract step (success) 06:41:04 INFO - [mozharness: 2016-10-22 13:41:04.242000Z] Running populate-webroot step. 06:41:04 INFO - Running pre-action listener: _resource_record_pre_action 06:41:04 INFO - Running main action method: populate_webroot 06:41:04 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 06:41:04 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 06:41:04 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 06:41:04 INFO - u'--tppagecycles', 06:41:04 INFO - u'7'], 06:41:04 INFO - u'tests': [u'tsvgm']}}, 06:41:04 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 06:41:04 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 06:41:04 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 06:41:04 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 06:41:04 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 06:41:04 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 06:41:04 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:04 INFO - u'talos_options': [u'--disable-e10s'], 06:41:04 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 06:41:04 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:04 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 06:41:04 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:04 INFO - u'talos_options': [u'--disable-e10s'], 06:41:04 INFO - u'tests': [u'damp', u'tps']}, 06:41:04 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:04 INFO - u'tests': [u'damp', u'tps']}, 06:41:04 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 06:41:04 INFO - u'tests': [u'dromaeo_dom']}, 06:41:04 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 06:41:04 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 06:41:04 INFO - u'tests': [u'basic_compositor_video']}, 06:41:04 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 06:41:04 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 06:41:04 INFO - u'tests': [u'a11yr', 06:41:04 INFO - u'ts_paint', 06:41:04 INFO - u'tpaint', 06:41:04 INFO - u'sessionrestore', 06:41:04 INFO - u'sessionrestore_no_auto_restore', 06:41:04 INFO - u'tabpaint']}, 06:41:04 INFO - u'other-e10s': {u'tests': [u'a11yr', 06:41:04 INFO - u'ts_paint', 06:41:04 INFO - u'tpaint', 06:41:04 INFO - u'sessionrestore', 06:41:04 INFO - u'sessionrestore_no_auto_restore', 06:41:04 INFO - u'tabpaint']}, 06:41:04 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 06:41:04 INFO - u'ts_paint', 06:41:04 INFO - u'tpaint', 06:41:04 INFO - u'sessionrestore', 06:41:04 INFO - u'sessionrestore_no_auto_restore', 06:41:04 INFO - u'tabpaint']}, 06:41:04 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 06:41:04 INFO - u'ts_paint', 06:41:04 INFO - u'tpaint', 06:41:04 INFO - u'sessionrestore', 06:41:04 INFO - u'sessionrestore_no_auto_restore', 06:41:04 INFO - u'tabpaint']}, 06:41:04 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 06:41:04 INFO - u'tests': [u'a11yr', 06:41:04 INFO - u'ts_paint', 06:41:04 INFO - u'tpaint', 06:41:04 INFO - u'sessionrestore', 06:41:04 INFO - u'sessionrestore_no_auto_restore', 06:41:04 INFO - u'tabpaint']}, 06:41:04 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 06:41:04 INFO - u'tests': [u'a11yr', 06:41:04 INFO - u'ts_paint', 06:41:04 INFO - u'tpaint', 06:41:04 INFO - u'sessionrestore', 06:41:04 INFO - u'sessionrestore_no_auto_restore', 06:41:04 INFO - u'tabpaint']}, 06:41:04 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 06:41:04 INFO - u'tests': [u'tsvgx', 06:41:04 INFO - u'tsvgr_opacity', 06:41:04 INFO - u'tart', 06:41:04 INFO - u'tscrollx', 06:41:04 INFO - u'cart']}, 06:41:04 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 06:41:04 INFO - u'tsvgr_opacity', 06:41:04 INFO - u'tart', 06:41:04 INFO - u'tscrollx', 06:41:04 INFO - u'cart']}, 06:41:04 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:04 INFO - u'talos_options': [u'--disable-e10s'], 06:41:04 INFO - u'tests': [u'tp5o']}, 06:41:04 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:04 INFO - u'tests': [u'tp5o']}, 06:41:04 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:04 INFO - u'talos_options': [u'--disable-e10s', 06:41:04 INFO - u'--xperf_path', 06:41:04 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:04 INFO - u'tests': [u'tp5n']}, 06:41:04 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:04 INFO - u'talos_options': [u'--xperf_path', 06:41:04 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:04 INFO - u'tests': [u'tp5n']}}, 06:41:04 INFO - u'talos.zip': {u'path': u'', 06:41:04 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:41:04 INFO - Running post-action listener: _resource_record_post_action 06:41:04 INFO - [mozharness: 2016-10-22 13:41:04.340000Z] Finished populate-webroot step (success) 06:41:04 INFO - [mozharness: 2016-10-22 13:41:04.340000Z] Running create-virtualenv step. 06:41:04 INFO - Running pre-action listener: _resource_record_pre_action 06:41:04 INFO - Running main action method: create_virtualenv 06:41:04 INFO - Creating virtualenv C:\slave\test\build/venv 06:41:04 INFO - mkdir: C:\slave\test\build\venv\Scripts 06:41:04 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 06:41:04 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'! 06:41:04 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 06:41:04 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 06:41:15 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 06:41:18 INFO - Installing distribute......................................................................................................................................................................................done. 06:41:19 INFO - Return code: 0 06:41:19 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 06:41:19 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 06:41:20 INFO - Reading from file tmpfile_stdout 06:41:20 INFO - Output received: 06:41:20 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 06:41:20 INFO - Using _rmtree_windows ... 06:41:20 INFO - Using _rmtree_windows ... 06:41:20 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 06:41: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')]} 06:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41: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')]} 06:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02419640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02451E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00518E60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02475E90>, '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 0x0048A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x024DE520>, '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 06:41: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', 'pip>=1.5'] in C:\slave\test\build 06:41: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 pip>=1.5 06:41:20 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:41:20 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 06:41:20 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:41:20 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:41:20 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:41:20 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 06:41:20 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:41:20 INFO - 'DCLOCATION': 'SCL3', 06:41:20 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:41:20 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:41:20 INFO - 'HOMEDRIVE': 'C:', 06:41:20 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 06:41:20 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:41:20 INFO - 'KTS_VERSION': '1.19c', 06:41:20 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 06:41:20 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 06:41:20 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:41:20 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:20 INFO - 'MOZ_NO_REMOTE': '1', 06:41:20 INFO - 'NO_EM_RESTART': '1', 06:41:20 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:41:20 INFO - 'OS': 'Windows_NT', 06:41:20 INFO - 'OURDRIVE': 'C:', 06:41: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;', 06:41:20 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:41:20 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:41:20 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:41:20 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:41:20 INFO - 'PROCESSOR_LEVEL': '6', 06:41:20 INFO - 'PROCESSOR_REVISION': '1e05', 06:41:20 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:41:20 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:41:20 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:41:20 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:41:20 INFO - 'PROMPT': '$P$G', 06:41:20 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:41:20 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:41:20 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:41:20 INFO - 'PWD': 'C:\\slave\\test', 06:41:20 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:41:20 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:41:20 INFO - 'SYSTEMDRIVE': 'C:', 06:41:20 INFO - 'SYSTEMROOT': 'C:\\windows', 06:41:20 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:20 INFO - 'TEST1': 'testie', 06:41:20 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:20 INFO - 'USERDOMAIN': 'T-W864-IX-098', 06:41:20 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 06:41:20 INFO - 'USERNAME': 'cltbld', 06:41:20 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 06:41:20 INFO - 'WINDIR': 'C:\\windows', 06:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:41:20 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:41:20 INFO - Downloading/unpacking pip>=1.5 06:41:24 INFO - Running setup.py egg_info for package pip 06:41:24 INFO - warning: no files found matching 'pip\cacert.pem' 06:41:24 INFO - warning: no files found matching '*.html' under directory 'docs' 06:41:24 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 06:41:24 INFO - no previously-included directories found matching 'docs\_build\_sources' 06:41:24 INFO - Installing collected packages: pip 06:41:24 INFO - Found existing installation: pip 0.8.2 06:41:24 INFO - Uninstalling pip: 06:41:24 INFO - Successfully uninstalled pip 06:41:24 INFO - Running setup.py install for pip 06:41:24 INFO - warning: no files found matching 'pip\cacert.pem' 06:41:24 INFO - warning: no files found matching '*.html' under directory 'docs' 06:41:24 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 06:41:24 INFO - no previously-included directories found matching 'docs\_build\_sources' 06:41:24 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 06:41:24 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 06:41:24 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 06:41:24 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 06:41:24 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 06:41:24 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 06:41:24 INFO - Successfully installed pip 06:41:24 INFO - Cleaning up... 06:41:24 INFO - Return code: 0 06:41:24 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 06:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:24 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 0x02419640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02451E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00518E60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02475E90>, '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 0x0048A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x024DE520>, '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 06:41:24 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 06:41:24 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 06:41:24 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:41:24 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 06:41:24 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:41:24 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:41:24 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:41:24 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 06:41:24 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:41:24 INFO - 'DCLOCATION': 'SCL3', 06:41:24 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:41:24 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:41:24 INFO - 'HOMEDRIVE': 'C:', 06:41:24 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 06:41:24 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:41:24 INFO - 'KTS_VERSION': '1.19c', 06:41:24 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 06:41:24 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 06:41:24 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:41:24 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:24 INFO - 'MOZ_NO_REMOTE': '1', 06:41:24 INFO - 'NO_EM_RESTART': '1', 06:41:24 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:41:24 INFO - 'OS': 'Windows_NT', 06:41:24 INFO - 'OURDRIVE': 'C:', 06:41:24 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 06:41:24 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:41:24 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:41:24 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:41:24 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:41:24 INFO - 'PROCESSOR_LEVEL': '6', 06:41:24 INFO - 'PROCESSOR_REVISION': '1e05', 06:41:24 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:41:24 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:41:24 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:41:24 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:41:24 INFO - 'PROMPT': '$P$G', 06:41:24 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:41:24 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:41:24 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:41:24 INFO - 'PWD': 'C:\\slave\\test', 06:41:24 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:41:24 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:41:24 INFO - 'SYSTEMDRIVE': 'C:', 06:41:24 INFO - 'SYSTEMROOT': 'C:\\windows', 06:41:24 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:24 INFO - 'TEST1': 'testie', 06:41:24 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:24 INFO - 'USERDOMAIN': 'T-W864-IX-098', 06:41:24 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 06:41:24 INFO - 'USERNAME': 'cltbld', 06:41:24 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 06:41:24 INFO - 'WINDIR': 'C:\\windows', 06:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:27 INFO - Downloading/unpacking psutil>=3.1.1 06:41:27 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 06:41:27 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 06:41:28 INFO - Installing collected packages: psutil 06:41:28 INFO - Successfully installed psutil 06:41:28 INFO - Cleaning up... 06:41:29 INFO - Return code: 0 06:41:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 06:41:29 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')]} 06:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:29 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')]} 06:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:29 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 0x02419640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02451E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00518E60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02475E90>, '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 0x0048A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x024DE520>, '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 06:41:29 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 06:41:29 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 06:41:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:41:29 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 06:41:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:41:29 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:41:29 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:41:29 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 06:41:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:41:29 INFO - 'DCLOCATION': 'SCL3', 06:41:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:41:29 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:41:29 INFO - 'HOMEDRIVE': 'C:', 06:41:29 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 06:41:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:41:29 INFO - 'KTS_VERSION': '1.19c', 06:41:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 06:41:29 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 06:41:29 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:41:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:29 INFO - 'MOZ_NO_REMOTE': '1', 06:41:29 INFO - 'NO_EM_RESTART': '1', 06:41:29 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:41:29 INFO - 'OS': 'Windows_NT', 06:41:29 INFO - 'OURDRIVE': 'C:', 06:41:29 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;', 06:41:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:41:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:41:29 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:41:29 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:41:29 INFO - 'PROCESSOR_LEVEL': '6', 06:41:29 INFO - 'PROCESSOR_REVISION': '1e05', 06:41:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:41:29 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:41:29 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:41:29 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:41:29 INFO - 'PROMPT': '$P$G', 06:41:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:41:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:41:29 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:41:29 INFO - 'PWD': 'C:\\slave\\test', 06:41:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:41:29 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:41:29 INFO - 'SYSTEMDRIVE': 'C:', 06:41:29 INFO - 'SYSTEMROOT': 'C:\\windows', 06:41:29 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:29 INFO - 'TEST1': 'testie', 06:41:29 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:29 INFO - 'USERDOMAIN': 'T-W864-IX-098', 06:41:29 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 06:41:29 INFO - 'USERNAME': 'cltbld', 06:41:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 06:41:29 INFO - 'WINDIR': 'C:\\windows', 06:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:41:29 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 06:41:29 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 06:41:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:41:30 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 06:41:30 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) 06:41:30 INFO - Installing collected packages: mozsystemmonitor 06:41:30 INFO - Running setup.py install for mozsystemmonitor 06:41:30 INFO - Successfully installed mozsystemmonitor 06:41:30 INFO - Cleaning up... 06:41:31 INFO - Return code: 0 06:41:31 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 06:41:31 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')]} 06:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:31 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')]} 06:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:31 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 0x02419640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02451E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00518E60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02475E90>, '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 0x0048A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x024DE520>, '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 06:41:31 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 06:41:31 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 06:41:31 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:41:31 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 06:41:31 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:41:31 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:41:31 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:41:31 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 06:41:31 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:41:31 INFO - 'DCLOCATION': 'SCL3', 06:41:31 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:41:31 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:41:31 INFO - 'HOMEDRIVE': 'C:', 06:41:31 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 06:41:31 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:41:31 INFO - 'KTS_VERSION': '1.19c', 06:41:31 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 06:41:31 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 06:41:31 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:41:31 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:31 INFO - 'MOZ_NO_REMOTE': '1', 06:41:31 INFO - 'NO_EM_RESTART': '1', 06:41:31 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:41:31 INFO - 'OS': 'Windows_NT', 06:41:31 INFO - 'OURDRIVE': 'C:', 06:41:31 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;', 06:41:31 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:41:31 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:41:31 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:41:31 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:41:31 INFO - 'PROCESSOR_LEVEL': '6', 06:41:31 INFO - 'PROCESSOR_REVISION': '1e05', 06:41:31 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:41:31 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:41:31 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:41:31 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:41:31 INFO - 'PROMPT': '$P$G', 06:41:31 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:41:31 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:41:31 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:41:31 INFO - 'PWD': 'C:\\slave\\test', 06:41:31 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:41:31 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:41:31 INFO - 'SYSTEMDRIVE': 'C:', 06:41:31 INFO - 'SYSTEMROOT': 'C:\\windows', 06:41:31 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:31 INFO - 'TEST1': 'testie', 06:41:31 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:31 INFO - 'USERDOMAIN': 'T-W864-IX-098', 06:41:31 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 06:41:31 INFO - 'USERNAME': 'cltbld', 06:41:31 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 06:41:31 INFO - 'WINDIR': 'C:\\windows', 06:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:31 INFO - Downloading/unpacking jsonschema==2.5.1 06:41:31 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 06:41:31 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 06:41:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:41:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:41:32 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 06:41:32 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 06:41:32 INFO - Downloading functools32-3.2.3-2.tar.gz 06:41:32 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 06:41:32 INFO - warning: no files found matching '*.txt' 06:41:32 INFO - no previously-included directories found matching 'build' 06:41:32 INFO - no previously-included directories found matching 'dist' 06:41:32 INFO - no previously-included directories found matching '.git*' 06:41:32 INFO - Installing collected packages: jsonschema, functools32 06:41:32 INFO - Running setup.py install for functools32 06:41:32 INFO - warning: no files found matching '*.txt' 06:41:32 INFO - no previously-included directories found matching 'build' 06:41:32 INFO - no previously-included directories found matching 'dist' 06:41:32 INFO - no previously-included directories found matching '.git*' 06:41:32 INFO - Successfully installed jsonschema functools32 06:41:32 INFO - Cleaning up... 06:41:33 INFO - Return code: 0 06:41:33 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 06:41:33 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')]} 06:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:33 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')]} 06:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:33 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 0x02419640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02451E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00518E60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02475E90>, '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 0x0048A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x024DE520>, '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 06:41:33 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 06:41:33 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 06:41:33 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:41:33 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 06:41:33 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:41:33 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:41:33 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:41:33 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 06:41:33 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:41:33 INFO - 'DCLOCATION': 'SCL3', 06:41:33 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:41:33 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:41:33 INFO - 'HOMEDRIVE': 'C:', 06:41:33 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 06:41:33 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:41:33 INFO - 'KTS_VERSION': '1.19c', 06:41:33 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 06:41:33 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 06:41:33 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:41:33 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:33 INFO - 'MOZ_NO_REMOTE': '1', 06:41:33 INFO - 'NO_EM_RESTART': '1', 06:41:33 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:41:33 INFO - 'OS': 'Windows_NT', 06:41:33 INFO - 'OURDRIVE': 'C:', 06:41:33 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;', 06:41:33 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:41:33 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:41:33 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:41:33 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:41:33 INFO - 'PROCESSOR_LEVEL': '6', 06:41:33 INFO - 'PROCESSOR_REVISION': '1e05', 06:41:33 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:41:33 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:41:33 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:41:33 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:41:33 INFO - 'PROMPT': '$P$G', 06:41:33 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:41:33 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:41:33 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:41:33 INFO - 'PWD': 'C:\\slave\\test', 06:41:33 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:41:33 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:41:33 INFO - 'SYSTEMDRIVE': 'C:', 06:41:33 INFO - 'SYSTEMROOT': 'C:\\windows', 06:41:33 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:33 INFO - 'TEST1': 'testie', 06:41:33 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:33 INFO - 'USERDOMAIN': 'T-W864-IX-098', 06:41:33 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 06:41:33 INFO - 'USERNAME': 'cltbld', 06:41:33 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 06:41:33 INFO - 'WINDIR': 'C:\\windows', 06:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 06:41:33 INFO - Cleaning up... 06:41:33 INFO - Return code: 0 06:41:33 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 06:41:33 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')]} 06:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:33 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')]} 06:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:33 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 0x02419640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02451E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00518E60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02475E90>, '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 0x0048A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x024DE520>, '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 06:41:33 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 06:41:33 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 06:41:33 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:41:33 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 06:41:33 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:41:33 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:41:33 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:41:33 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 06:41:33 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:41:33 INFO - 'DCLOCATION': 'SCL3', 06:41:33 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:41:33 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:41:33 INFO - 'HOMEDRIVE': 'C:', 06:41:33 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 06:41:33 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:41:33 INFO - 'KTS_VERSION': '1.19c', 06:41:33 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 06:41:33 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 06:41:33 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:41:33 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:33 INFO - 'MOZ_NO_REMOTE': '1', 06:41:33 INFO - 'NO_EM_RESTART': '1', 06:41:33 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:41:33 INFO - 'OS': 'Windows_NT', 06:41:33 INFO - 'OURDRIVE': 'C:', 06:41:33 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;', 06:41:33 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:41:33 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:41:33 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:41:33 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:41:33 INFO - 'PROCESSOR_LEVEL': '6', 06:41:33 INFO - 'PROCESSOR_REVISION': '1e05', 06:41:33 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:41:33 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:41:33 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:41:33 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:41:33 INFO - 'PROMPT': '$P$G', 06:41:33 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:41:33 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:41:33 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:41:33 INFO - 'PWD': 'C:\\slave\\test', 06:41:33 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:41:33 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:41:33 INFO - 'SYSTEMDRIVE': 'C:', 06:41:33 INFO - 'SYSTEMROOT': 'C:\\windows', 06:41:33 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:33 INFO - 'TEST1': 'testie', 06:41:33 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:33 INFO - 'USERDOMAIN': 'T-W864-IX-098', 06:41:33 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 06:41:33 INFO - 'USERNAME': 'cltbld', 06:41:33 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 06:41:33 INFO - 'WINDIR': 'C:\\windows', 06:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:34 INFO - Downloading/unpacking blobuploader==1.2.4 06:41:34 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 06:41:34 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 06:41:35 INFO - Downloading blobuploader-1.2.4.tar.gz 06:41:35 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 06:41:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:41:35 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 06:41:35 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 06:41:35 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 06:41:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:41:35 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 06:41:35 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 06:41:35 INFO - Downloading docopt-0.6.1.tar.gz 06:41:35 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 06:41:35 INFO - Installing collected packages: blobuploader, requests, docopt 06:41:35 INFO - Running setup.py install for blobuploader 06:41:36 INFO - Running setup.py install for requests 06:41:36 INFO - Running setup.py install for docopt 06:41:36 INFO - Successfully installed blobuploader requests docopt 06:41:36 INFO - Cleaning up... 06:41:37 INFO - Return code: 0 06:41:37 INFO - Installing None into virtualenv C:\slave\test\build/venv 06:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:37 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 0x02419640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02451E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00518E60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02475E90>, '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 0x0048A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x024DE520>, '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 06:41:37 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 06:41:37 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 06:41:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:41:37 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 06:41:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:41:37 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:41:37 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:41:37 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 06:41:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:41:37 INFO - 'DCLOCATION': 'SCL3', 06:41:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:41:37 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:41:37 INFO - 'HOMEDRIVE': 'C:', 06:41:37 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 06:41:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:41:37 INFO - 'KTS_VERSION': '1.19c', 06:41:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 06:41:37 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 06:41:37 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:41:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:37 INFO - 'MOZ_NO_REMOTE': '1', 06:41:37 INFO - 'NO_EM_RESTART': '1', 06:41:37 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:41:37 INFO - 'OS': 'Windows_NT', 06:41:37 INFO - 'OURDRIVE': 'C:', 06:41:37 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;', 06:41:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:41:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:41:37 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:41:37 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:41:37 INFO - 'PROCESSOR_LEVEL': '6', 06:41:37 INFO - 'PROCESSOR_REVISION': '1e05', 06:41:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:41:37 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:41:37 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:41:37 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:41:37 INFO - 'PROMPT': '$P$G', 06:41:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:41:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:41:37 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:41:37 INFO - 'PWD': 'C:\\slave\\test', 06:41:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:41:37 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:41:37 INFO - 'SYSTEMDRIVE': 'C:', 06:41:37 INFO - 'SYSTEMROOT': 'C:\\windows', 06:41:37 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:37 INFO - 'TEST1': 'testie', 06:41:37 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:37 INFO - 'USERDOMAIN': 'T-W864-IX-098', 06:41:37 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 06:41:37 INFO - 'USERNAME': 'cltbld', 06:41:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 06:41:37 INFO - 'WINDIR': 'C:\\windows', 06:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:41:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 06:41:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3iqzz_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 06:41:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 06:41:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gowec8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 06:41:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 06:41:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-j0zguh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 06:41:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 06:41:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fx_rm1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 06:41:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 06:41:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-z8hiyl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 06:41:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 06:41:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xagki6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 06:41:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 06:41:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o_eqv6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 06:41:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 06:41:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lurjio-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 06:41:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 06:41:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-osy6ai-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 06:41:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 06:41:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dhrv5h-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 06:41:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 06:41:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7fh2ek-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 06:41:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 06:41:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ytlh0r-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 06:41:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 06:41:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5v7sz5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 06:41:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 06:41:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mxt56m-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 06:41:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 06:41:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jf69uq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 06:41:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 06:41:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ynfod6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 06:41:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 06:41:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rrddlp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 06:41:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:41:40 INFO - Running setup.py install for manifestparser 06:41:40 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 06:41:40 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 06:41:40 INFO - Running setup.py install for mozcrash 06:41:41 INFO - Running setup.py install for mozdebug 06:41:41 INFO - Running setup.py install for mozdevice 06:41:41 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 06:41:41 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 06:41:41 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 06:41:41 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 06:41:42 INFO - Running setup.py install for mozfile 06:41:42 INFO - Running setup.py install for mozhttpd 06:41:42 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 06:41:42 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 06:41:42 INFO - Running setup.py install for mozinfo 06:41:43 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 06:41:43 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 06:41:43 INFO - Running setup.py install for mozInstall 06:41:43 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 06:41:43 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 06:41:43 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 06:41:43 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 06:41:43 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 06:41:43 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 06:41:43 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 06:41:43 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 06:41:43 INFO - Running setup.py install for mozleak 06:41:43 INFO - Running setup.py install for mozlog 06:41:44 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 06:41:44 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 06:41:44 INFO - Running setup.py install for moznetwork 06:41:45 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 06:41:45 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 06:41:45 INFO - Running setup.py install for mozprocess 06:41:45 INFO - Running setup.py install for mozprofile 06:41:46 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 06:41:46 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 06:41:46 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 06:41:46 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 06:41:46 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 06:41:46 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 06:41:46 INFO - Running setup.py install for mozrunner 06:41:46 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 06:41:46 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 06:41:47 INFO - Running setup.py install for mozscreenshot 06:41:47 INFO - Running setup.py install for moztest 06:41:47 INFO - Running setup.py install for mozversion 06:41:47 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 06:41:47 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 06:41:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:41:48 INFO - Cleaning up... 06:41:48 INFO - Return code: 0 06:41:48 INFO - Installing None into virtualenv C:\slave\test\build/venv 06:41:48 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')]} 06:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:48 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')]} 06:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:48 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 0x02419640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02451E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00518E60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02475E90>, '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 0x0048A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x024DE520>, '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 06:41:48 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 06:41:48 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 06:41:48 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:41:48 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 06:41:48 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:41:48 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:41:48 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:41:48 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 06:41:48 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:41:48 INFO - 'DCLOCATION': 'SCL3', 06:41:48 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:41:48 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:41:48 INFO - 'HOMEDRIVE': 'C:', 06:41:48 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 06:41:48 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:41:48 INFO - 'KTS_VERSION': '1.19c', 06:41:48 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 06:41:48 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 06:41:48 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:41:48 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:48 INFO - 'MOZ_NO_REMOTE': '1', 06:41:48 INFO - 'NO_EM_RESTART': '1', 06:41:48 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:41:48 INFO - 'OS': 'Windows_NT', 06:41:48 INFO - 'OURDRIVE': 'C:', 06:41:48 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;', 06:41:48 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:41:48 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:41:48 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:41:48 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:41:48 INFO - 'PROCESSOR_LEVEL': '6', 06:41:48 INFO - 'PROCESSOR_REVISION': '1e05', 06:41:48 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:41:48 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:41:48 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:41:48 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:41:48 INFO - 'PROMPT': '$P$G', 06:41:48 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:41:48 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:41:48 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:41:48 INFO - 'PWD': 'C:\\slave\\test', 06:41:48 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:41:48 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:41:48 INFO - 'SYSTEMDRIVE': 'C:', 06:41:48 INFO - 'SYSTEMROOT': 'C:\\windows', 06:41:48 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:48 INFO - 'TEST1': 'testie', 06:41:48 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:48 INFO - 'USERDOMAIN': 'T-W864-IX-098', 06:41:48 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 06:41:48 INFO - 'USERNAME': 'cltbld', 06:41:48 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 06:41:48 INFO - 'WINDIR': 'C:\\windows', 06:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 06:41:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6mt3ye-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 06:41:48 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)) 06:41:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 06:41:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vop4fi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 06:41:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 06:41:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 06:41:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-k3qmtp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 06:41:48 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)) 06:41:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 06:41:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qfdk5f-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 06:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 06:41:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 06:41:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jb0i62-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 06:41:49 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)) 06:41:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 06:41:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jqgdpz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 06:41:49 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)) 06:41:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 06:41:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jaswlf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 06:41:49 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)) 06:41:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 06:41:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rgl5p9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 06:41:49 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)) 06:41:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 06:41:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3ewwpt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 06:41:49 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)) 06:41:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 06:41:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pzm5ev-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 06:41:49 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)) 06:41:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 06:41:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iceetv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 06:41:49 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)) 06:41:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 06:41:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jr3jlp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 06:41:50 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)) 06:41:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 06:41:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-oly95b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 06:41:50 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)) 06:41:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 06:41:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6rje6w-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 06:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:41:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 06:41:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-icg0rr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 06:41:50 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)) 06:41:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 06:41:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qk5mtp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 06:41:50 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)) 06:41:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 06:41:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ug9xyo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 06:41:50 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)) 06:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 06:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 06:41:50 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)) 06:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 06:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 06:41:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 06:41:50 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 06:41:50 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 06:41:51 INFO - Downloading blessings-1.6.tar.gz 06:41:51 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 06:41:51 INFO - Installing collected packages: blessings 06:41:51 INFO - Running setup.py install for blessings 06:41:52 INFO - Successfully installed blessings 06:41:52 INFO - Cleaning up... 06:41:55 INFO - Return code: 0 06:41:55 INFO - Done creating virtualenv C:\slave\test\build/venv. 06:41:55 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 06:41:55 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 06:41:55 INFO - Reading from file tmpfile_stdout 06:41:55 INFO - Using _rmtree_windows ... 06:41:55 INFO - Using _rmtree_windows ... 06:41:55 INFO - Current package versions: 06:41:55 INFO - blessings == 1.6 06:41:55 INFO - blobuploader == 1.2.4 06:41:55 INFO - docopt == 0.6.1 06:41:55 INFO - functools32 == 3.2.3-2 06:41:55 INFO - jsonschema == 2.5.1 06:41:55 INFO - manifestparser == 1.1 06:41:55 INFO - mozInstall == 1.12 06:41:55 INFO - mozcrash == 0.17 06:41:55 INFO - mozdebug == 0.1 06:41:55 INFO - mozdevice == 0.48 06:41:55 INFO - mozfile == 1.2 06:41:55 INFO - mozhttpd == 0.7 06:41:55 INFO - mozinfo == 0.9 06:41:55 INFO - mozleak == 0.1 06:41:55 INFO - mozlog == 3.4 06:41:55 INFO - moznetwork == 0.27 06:41:55 INFO - mozprocess == 0.23 06:41:55 INFO - mozprofile == 0.28 06:41:55 INFO - mozrunner == 6.12 06:41:55 INFO - mozscreenshot == 0.1 06:41:55 INFO - mozsystemmonitor == 0.3 06:41:55 INFO - moztest == 0.7 06:41:55 INFO - mozversion == 1.4 06:41:55 INFO - psutil == 3.1.1 06:41:55 INFO - requests == 1.2.3 06:41:55 INFO - Installing None into virtualenv C:\slave\test\build/venv 06:41:55 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')]} 06:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:55 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')]} 06:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:55 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 0x02419640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02451E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00518E60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02475E90>, '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 0x0048A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x024DE520>, '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 06:41:55 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 06:41:55 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 06:41:55 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:41:55 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 06:41:55 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:41:55 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:41:55 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:41:55 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 06:41:55 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:41:55 INFO - 'DCLOCATION': 'SCL3', 06:41:55 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:41:55 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:41:55 INFO - 'HOMEDRIVE': 'C:', 06:41:55 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 06:41:55 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:41:55 INFO - 'KTS_VERSION': '1.19c', 06:41:55 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 06:41:55 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 06:41:55 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:41:55 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:55 INFO - 'MOZ_NO_REMOTE': '1', 06:41:55 INFO - 'NO_EM_RESTART': '1', 06:41:55 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:41:55 INFO - 'OS': 'Windows_NT', 06:41:55 INFO - 'OURDRIVE': 'C:', 06:41:55 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;', 06:41:55 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:41:55 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:41:55 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:41:55 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:41:55 INFO - 'PROCESSOR_LEVEL': '6', 06:41:55 INFO - 'PROCESSOR_REVISION': '1e05', 06:41:55 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:41:55 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:41:55 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:41:55 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:41:55 INFO - 'PROMPT': '$P$G', 06:41:55 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:41:55 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:41:55 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:41:55 INFO - 'PWD': 'C:\\slave\\test', 06:41:55 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:41:55 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:41:55 INFO - 'SYSTEMDRIVE': 'C:', 06:41:55 INFO - 'SYSTEMROOT': 'C:\\windows', 06:41:55 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:55 INFO - 'TEST1': 'testie', 06:41:55 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:55 INFO - 'USERDOMAIN': 'T-W864-IX-098', 06:41:55 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 06:41:55 INFO - 'USERNAME': 'cltbld', 06:41:55 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 06:41:55 INFO - 'WINDIR': 'C:\\windows', 06:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 INFO - Cleaning up... 06:41:55 INFO - Return code: 0 06:41:55 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 06:41:55 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')]} 06:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:55 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')]} 06:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:55 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 0x02419640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02451E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00518E60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02475E90>, '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 0x0048A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x024DE520>, '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 06:41:55 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 06:41:55 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 06:41:55 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:41:55 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 06:41:55 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:41:55 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:41:55 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:41:55 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 06:41:55 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:41:55 INFO - 'DCLOCATION': 'SCL3', 06:41:55 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:41:55 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:41:55 INFO - 'HOMEDRIVE': 'C:', 06:41:55 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 06:41:55 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:41:55 INFO - 'KTS_VERSION': '1.19c', 06:41:55 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 06:41:55 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 06:41:55 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:41:55 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:55 INFO - 'MOZ_NO_REMOTE': '1', 06:41:55 INFO - 'NO_EM_RESTART': '1', 06:41:55 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:41:55 INFO - 'OS': 'Windows_NT', 06:41:55 INFO - 'OURDRIVE': 'C:', 06:41:55 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;', 06:41:55 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:41:55 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:41:55 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:41:55 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:41:55 INFO - 'PROCESSOR_LEVEL': '6', 06:41:55 INFO - 'PROCESSOR_REVISION': '1e05', 06:41:55 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:41:55 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:41:55 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:41:55 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:41:55 INFO - 'PROMPT': '$P$G', 06:41:55 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:41:55 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:41:55 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:41:55 INFO - 'PWD': 'C:\\slave\\test', 06:41:55 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:41:55 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:41:55 INFO - 'SYSTEMDRIVE': 'C:', 06:41:55 INFO - 'SYSTEMROOT': 'C:\\windows', 06:41:55 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:55 INFO - 'TEST1': 'testie', 06:41:55 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:41:55 INFO - 'USERDOMAIN': 'T-W864-IX-098', 06:41:55 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 06:41:55 INFO - 'USERNAME': 'cltbld', 06:41:55 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 06:41:55 INFO - 'WINDIR': 'C:\\windows', 06:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 06:41:56 INFO - Cleaning up... 06:41:56 INFO - Return code: 0 06:41:56 INFO - Running post-action listener: _resource_record_post_action 06:41:56 INFO - Running post-action listener: _start_resource_monitoring 06:41:56 INFO - Starting resource monitoring. 06:41:56 INFO - [mozharness: 2016-10-22 13:41:56.346000Z] Finished create-virtualenv step (success) 06:41:56 INFO - [mozharness: 2016-10-22 13:41:56.346000Z] Running install step. 06:41:56 INFO - Running pre-action listener: _resource_record_pre_action 06:41:56 INFO - Running main action method: install 06:41:56 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 06:41:56 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 06:41:56 INFO - Reading from file tmpfile_stdout 06:41:56 INFO - Using _rmtree_windows ... 06:41:56 INFO - Using _rmtree_windows ... 06:41:56 INFO - Detecting whether we're running mozinstall >=1.0... 06:41:56 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 06:41:56 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 06:41:56 INFO - Reading from file tmpfile_stdout 06:41:56 INFO - Output received: 06:41:56 INFO - Usage: mozinstall-script.py [options] installer 06:41:56 INFO - Options: 06:41:56 INFO - -h, --help show this help message and exit 06:41:56 INFO - -d DEST, --destination=DEST 06:41:56 INFO - Directory to install application into. [default: 06:41:56 INFO - "C:\slave\test"] 06:41:56 INFO - --app=APP Application being installed. [default: firefox] 06:41:56 INFO - Using _rmtree_windows ... 06:41:56 INFO - Using _rmtree_windows ... 06:41:56 INFO - mkdir: C:\slave\test\build\application 06:41:56 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-52.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 06:41:56 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-52.0a1.en-US.win64.zip --destination C:\slave\test\build\application ProcessManager NOT managing child processes 06:41:59 INFO - Reading from file tmpfile_stdout 06:41:59 INFO - Output received: 06:41:59 INFO - C:\slave\test\build\application\firefox\firefox.exe 06:41:59 INFO - Using _rmtree_windows ... 06:41:59 INFO - Using _rmtree_windows ... 06:41:59 INFO - Running post-action listener: _resource_record_post_action 06:41:59 INFO - [mozharness: 2016-10-22 13:41:59.097000Z] Finished install step (success) 06:41:59 INFO - [mozharness: 2016-10-22 13:41:59.097000Z] Running run-tests step. 06:41:59 INFO - Running pre-action listener: _resource_record_pre_action 06:41:59 INFO - Running main action method: run_tests 06:41:59 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 06:41:59 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 06:41:59 INFO - Python 2.7.3 06:41:59 INFO - Return code: 0 06:41:59 INFO - grabbing minidump binary from tooltool 06:41:59 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')]} 06:41:59 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 0x02475E90>, '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 0x0048A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x024DE520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 06:41:59 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 06:41:59 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 06:41:59 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 06:41:59 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 06:42:01 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmprof7iz 06:42:01 INFO - INFO - File integrity verified, renaming tmprof7iz to win32-minidump_stackwalk.exe 06:42:01 INFO - Return code: 0 06:42:01 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 06:42:01 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 06:42:01 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 06:42:01 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 06:42:01 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 06:42:01 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.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 06:42:01 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Firefox --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.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 06:42:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:42:01 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Roaming', 06:42:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:42:01 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:42:01 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:42:01 INFO - 'COMPUTERNAME': 'T-W864-IX-098', 06:42:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:42:01 INFO - 'DCLOCATION': 'SCL3', 06:42:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:42:01 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:42:01 INFO - 'HOMEDRIVE': 'C:', 06:42:01 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-098', 06:42:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:42:01 INFO - 'KTS_VERSION': '1.19c', 06:42:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-098\\AppData\\Local', 06:42:01 INFO - 'LOGONSERVER': '\\\\T-W864-IX-098', 06:42:01 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 06:42:01 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 06:42:01 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:42:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:01 INFO - 'MOZ_NO_REMOTE': '1', 06:42:01 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 06:42:01 INFO - 'NO_EM_RESTART': '1', 06:42:01 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:42:01 INFO - 'OS': 'Windows_NT', 06:42:01 INFO - 'OURDRIVE': 'C:', 06:42:01 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 06:42:01 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:42:01 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:42:01 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:42:01 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:42:01 INFO - 'PROCESSOR_LEVEL': '6', 06:42:01 INFO - 'PROCESSOR_REVISION': '1e05', 06:42:01 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:42:01 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:42:01 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:42:01 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:42:01 INFO - 'PROMPT': '$P$G', 06:42:01 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:42:01 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:42:01 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:42:01 INFO - 'PWD': 'C:\\slave\\test', 06:42:01 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 06:42:01 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:42:01 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:42:01 INFO - 'SYSTEMDRIVE': 'C:', 06:42:01 INFO - 'SYSTEMROOT': 'C:\\windows', 06:42:01 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:42:01 INFO - 'TEST1': 'testie', 06:42:01 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:42:01 INFO - 'USERDOMAIN': 'T-W864-IX-098', 06:42:01 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-098', 06:42:01 INFO - 'USERNAME': 'cltbld', 06:42:01 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-098', 06:42:01 INFO - 'WINDIR': 'C:\\windows', 06:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:42:01 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.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 06:42:02 INFO - mozversion application_buildid: 20161022030204 06:42:02 INFO - mozversion application_changeset: 5639a9f476d08f300c079117e61697f5026b6367 06:42:02 INFO - mozversion application_display_name: Nightly 06:42:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:42:02 INFO - mozversion application_name: Firefox 06:42:02 INFO - mozversion application_remotingname: firefox 06:42:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:42:02 INFO - mozversion application_vendor: Mozilla 06:42:02 INFO - mozversion application_version: 52.0a1 06:42:02 INFO - mozversion platform_buildid: 20161022030204 06:42:02 INFO - mozversion platform_changeset: 5639a9f476d08f300c079117e61697f5026b6367 06:42:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:42:02 INFO - mozversion platform_version: 52.0a1 06:42:02 INFO - using testdate: 1477143722 06:42:02 INFO - actual date: 1477143722 06:42:02 INFO - starting webserver on 'localhost:49288' 06:42:02 INFO - SUITE-START | Running 2 tests 06:42:02 INFO - TEST-START | dromaeo_css 06:42:02 INFO - operating with platform_type : w8_ 06:42:02 INFO - Initialising browser for dromaeo_css test... 06:42:02 INFO - TEST-INFO | started process 3576 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpruw5ek\profile http://localhost:49288/getInfo.html) 06:42:09 INFO - PROCESS | 3576 | __metrics Screen width/height:1600/1200 06:42:09 INFO - PROCESS | 3576 | colorDepth:24 06:42:09 INFO - PROCESS | 3576 | Browser inner width/height: 1010/674 06:42:09 INFO - PROCESS | 3576 | __metrics 06:42:10 INFO - PROCESS | 3576 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:42:10 INFO - PROCESS | 3576 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:42:12 INFO - TEST-INFO | 3576: exit 0 06:42:12 INFO - Browser initialized. 06:42:12 INFO - Running cycle 1/1 for dromaeo_css test... 06:42:12 INFO - TEST-INFO | started process 2544 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpruw5ek\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:12 INFO - PROCESS | 2544 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 06:42:23 INFO - PROCESS | 2544 | RSS: Main: 160329728 06:42:23 INFO - PROCESS | 2544 | 06:43:15 INFO - PROCESS | 2544 | 1477143795012 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] 06:45:24 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49288/tests/dromaeo/cssquery-ext.html) 06:45:27 INFO - PROCESS | 2544 | RSS: Main: 343142400 06:45:27 INFO - PROCESS | 2544 | 06:48:30 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-ext.html (next: http://localhost:49288/tests/dromaeo/cssquery-jquery.html) 06:48:30 INFO - PROCESS | 2544 | RSS: Main: 229699584 06:48:30 INFO - PROCESS | 2544 | 06:51:32 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49288/tests/dromaeo/cssquery-mootools.html) 06:51:33 INFO - PROCESS | 2544 | RSS: Main: 178655232 06:51:33 INFO - PROCESS | 2544 | 06:54:35 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49288/tests/dromaeo/cssquery-prototype.html) 06:54:35 INFO - PROCESS | 2544 | RSS: Main: 178360320 06:54:35 INFO - PROCESS | 2544 | 06:57:38 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49288/tests/dromaeo/cssquery-yui.html) 06:57:39 INFO - PROCESS | 2544 | RSS: Main: 168902656 06:57:39 INFO - PROCESS | 2544 | 07:00:42 INFO - PROCESS | 2544 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-yui.html (next: http://localhost:49288/tests/dromaeo/cssquery-dojo.html) 07:00:42 INFO - PROCESS | 2544 | RSS: Main: 208703488 07:00:42 INFO - PROCESS | 2544 | 07:00:42 INFO - PROCESS | 2544 | __start_tp_report 07:00:42 INFO - PROCESS | 2544 | _x_x_mozilla_page_load 07:00:42 INFO - PROCESS | 2544 | _x_x_mozilla_page_load_details 07:00:42 INFO - PROCESS | 2544 | |i|pagename|runs| 07:00:42 INFO - PROCESS | 2544 | |0;dojo.html;2857.4713677969576;2876.424715056989;2890.973704334961;2911.6651585067725;2920.2115428834213;5138.152204886194;5151.639385243035;5155.871103222421;5164.664296820704;5239.161734122541;5192.506711862367;5251.894962100756;5255.264263003182;5270.420253772082;5280.392754833195;4726.7400292983875;4726.8581942541605;4737.431508219019;4758.452777930548;4803.279508073782;4763.333133361332;4781.928271075936;4787.880302992436;4795.664303498756;4808.711477311355;4620.960283936104;4634.490206077328;4666.2767271073035;4760.2383618621025;4763.880488085297;4686.062787442491;4691.929621055687;4715.552022557851;4723;4744.786484608167;4592.173408786417;4639.234526303156;4653.069386122789;4657.767111644438;4760.857174284777;4905.386826646669;5192;5193.532582067632;5198.454162312978;5256.763445644955;5586.776528938878;5595.1886976388605;5612.214289999403;5658.151277308396;5658.321001479849;5698.6580805151825;5713.857153571153;5728.656280623134;5744.597878148531;5745.942540574624;5055.216441451581;5141.408737995103;5201.323827902386;5245.816396426183;5281.234221037928;5786.103154011135;5806.129080637854;5819.243498345188;5824.184614154022;5825.1844741736195;5520.806771762969;5530.806421775219;5549.5837812164245;5551.666899986014;5562.054450743383;5492.313460817398;5557.194206839986;5576.749046292845;5584.21820945068;5604.663720176803;5582.218489411485;5583.609147359727;5592.217089607459;5646.971765141148;5667.206591077253;5559.221708960748;5569.164625306155;5585.050541407889;5603.831885043455;5628.465295796893;3769.133099387156;3825.947864337274;3833.0034191110512;3836.462895194675;3866.709996750255;3296.901092967215;3314.105191598255;3329.9667003329655;3346.263821959165;3350.1959529712694;5237.790488380499;5242.580593552507;5249.816256431007;5253.527182553588;5258.605604579595;5624.690642014647;5648.604597678205;5656.660600363992;5660.801871934463;5680.630759000652;5148.562372198405;5181.4559471255725;5244.187150991603;5245.554127899095;5247.081760691864;4558.5897269245925;4573.176828170895;4625.976870115628;4629.189891768927;4632.911265852522;5760.53915686744;5781.537477001913;5782.6241294317415;5783.913241301299;5790.189373487715;5568.470995255444;5651.858703532444;5654.727686270557;5674.716264186856;5768.423157684198;5726.4273572642405;5737.74180161902;5769.07694768835;5774.1916131740745;5798.362180160095;5566.443355664401;5568.498835104698;5596.552275817843;5609.074502707171;5647.463490968352;5664.065429204135;5675.035244008611;5699.059655157019;5709.714514274353;5712.257406537124;5359.062164121341;5471.753771080391;5472.562195024469;5553.305836770403;5555.3611334697025;5540.168974653834;5543.085390910454;5545.833624991256;5547.195656629686;5549.38956714753;5415.539679127318;5462.153366228241;5475.932193222284;5482.80810171642;5487.972560137174;5518.144687573433;5549.5837812163445;5572.3034620672415;5572.972135139298;5587.636803607753;5467.097928841856;5496.725163741877;5505.834824955257;5517.69652669107;5518.255035570147 07:00:42 INFO - PROCESS | 2544 | |1;ext.html;554.839096661968;570.9200711900332;575.8474004388835;581.7905554000556;583.3903570768548;28307.43385132296;37487.62512374879;38630.8068459658;38706.41940370897;40865.38701919466;40348.59651403485;40619;40631.39052914209;40863.18273634533;40919.59080409195;8437.831243375129;8562.229399354057;8596.613152408125;8603.698870539532;8608.956955215246;8400.41197116202;8474.364422668325;8484.490930544156;8499.575021248944;8503.82992340156;8464.06895241523;8479.66081356745;8505.574721263944;8515.74452766418;8515.829683406328;8442.451240669337;8456.957715211416;8484.618192181366;8493.787655308604;8497.490150590922;8388.454750441262;8400.075991640915;8448.450850694746;8459.323254139654;8464.66141354345;37479.43780843289;37756.433653495216;37829.81085094585;37876;37890.24219515622;3130;3353.1281866714585;3438.2951494943477;3556.6798988090936;3600.765950213228;29411;29550.85224573885;29919.551206731918;30029.399412011855;30558.38883222323;3966.7818269995137;3968.980155099206;3996.360582306846;4017;4108.979455102735;279751;280036;280864;281088.70201681944;281558;28953.565696514568;49484.50515494871;49569;49808.28355037854;49896.50103498991;29854.552181717292;31756;31812.363752724817;31903.680963190534;31923.201919951724;14065.507707230197;14080.929595352163;14195.929020354832;14213.85786142146;14214;11347.886521134847;11374.033207177483;11393.601223957121;11426.657200284004;11476.713082173012;7029.89455158173;7149.60677162761;7201.919712043235;7233.204347521769;7243.949627304117;2798.3843554417995;2825.6891741908375;2832;2861.971380286212;2865.441238958425;825.2655136928139;859.0464584311409;879.7932485865816;922.114769820966;945.026622578745;27565.724342756715;27782;27850.303742406195;27955.253257592663;27962;940.6519587752439;959.8752162218867;967.6564819489121;1007.5264625625944;1048.1614708233383;14175.782085528337;14230.359633816503;14851.108933464027;14883.10701357922;14971.925140374446;449405;451151;452812;453111;453329;50184.74907625438;50255;50486;50584.747076264386;50606;1101.6364599682086;1115.7712668903018;1163.7207070303236;1192.0523184068686;1204.6867814368327;28207;28505.714942851137;28775.280617984718;28992.275193120342;29037.12888613345;42814.35778463388;43691.34462983121;43753.78123109364;43785.34321985109;43928.78035609802;313664;314561;318977;319648;321089;21612.190415245917;22348.77651223467;23429.414264642837;24787.256382307838;25736.61395079113;40547.797261013504;41080.794596026826;41116.38325425181;41193;41599.168016640106;35134.82432587821;35672;35787.64212357843;36226;36317;35465.64534354623;35776.28447431089;35907.10232244215;35924.82037589795;36210.8189459051;33435.83282083574;34033.31933361368;34063;34393.656063440045;34516.48225276673;30872.53691194589;32280.515792263606;32323.35353292874;32374.514382283814;32534.02397928066;23993;24248.049945353807;24295.63556546618;24385;24448.388790280384 07:00:42 INFO - PROCESS | 2544 | |2;jquery.html;332.5244899793295;335.55371356096396;336.794555321254;346.3073852295409;354.09881850689993;16176.676466470679;16820.495385138434;17398.82601173988;17582.560435989108;17740.29038838448;9891.961344058878;9933;9965.900340996588;9993.100620944113;10007.149392301644;4697.084068606615;4759.571638552529;4804.279358096296;4804.639652026094;4806.879828004293;4972.825951091712;5204.843854684365;5240.816571420001;5318.867028324285;5319.494648008433;5285.365756109272;5294.655847369928;5299.364076310848;5300.178472336794;5302.522772950434;5491.341039075297;5768.42315768424;5806.796762113348;5813.06990881459;5816.1566572846705;4510.932336014962;5107.642465027449;5120.692758434506;5123.462036486152;5132.871678208075;10279;11226.270292430965;11249.71875703114;11251.493682784294;11258.43707814606;1962.479942815155;1973.851961102923;1980.9108590113478;2000.6598878190744;2058.8661736987046;7948.602569871541;7955.562444065574;8177.386695997764;8197.79505512361;8242.423030387876;1676.6730487554933;1705.5480297721115;1719.6904557179703;1749.8425141737177;1778.0665150795935;73727.63136184338;73909.63045184793;74261.62869185673;75248.24751752467;75291.6235418825;9084.500352480545;9130.81738365229;9220.124088211609;9243.630254789734;9407.341486096044;12452.688682783002;12489.18993226535;12560.937195313965;12607.747845043232;12616.873831261753;6924.295869658048;7161.427085833121;7200.387967022862;7209.423246140401;7349.889751653729;7221.53060051095;7296.562206267641;7321.377682897013;7323.597202153826;7424.628768561658;3751.81240937952;3772.396416573335;3785.870378537487;3786.7917264550165;3820.9683385485764;1578.565894379032;1611.154144074347;1625.609853635119;1654.7186978213733;1658.8092369377434;789.6959670526888;800.4996876951905;855.8673405622138;871.4727589808201;930.042056681619;16399.098049607386;16495.752563711554;16511.926724762852;17001.23494442753;17246.65506689859;815.2051749544147;830.5349004557346;842.9072801991776;874.1127755328347;888.05865782271;9026.729198124067;9174.17432431071;9221;9359.867165621723;9424.387414818015;401087;402425;405751;410730;413269;82048;83533.58233208796;84956;85335.57332213424;86956;879.5778026547293;884.186548375496;895.1496078725237;896.5024411451576;897.0222457521203;14671.92664036673;14750.409983600965;14753.336099875745;15121.470748523749;15325.080495170325;30462.84768576143;34729.47905781466;35642.821785891945;35669.46495802513;37232.25535489329;46954.76522617365;49464;49756.75121624514;50068.24897626611;50964.490355097456;7024.297570242935;7100.893486597602;7190.88541276103;7198.8920166198595;7222.74720384784;8928.553572321487;11102.666919992413;11395.544178232778;11544.82682759776;11744.941275293912;8477.152284771473;9092.408993415407;9821;9885.752856178653;10129.898701012895;9791.804163916824;9854.802903941738;9924.652637157666;10222.539985700512;10328.277020608486;9626.085521875411;9661.855072174063;9703.272254580794;9878.604855805976;9909.45497997617;6900.206476255295;6969.860602787814;7082.256363081802;7095.574265544084;7316.158641756266;6960.582365058112;9696.321257511907;9763;10228.488575571042;10766.676999690022 07:00:42 INFO - PROCESS | 2544 | |3;mootools.html;1204.2774335398767;1272.7327261275132;1304.9543265985692;1319.881210691038;1541.3295216580796;6758.986152077185;7422.554646721193;7695.653695583698;7701.191374905638;7711.845763084735;7465.925340746591;7636.503627264238;7638.083429988395;7777.650005749741;7806.9609651951805;2012.1046134470166;2043.1520918818671;2044.8364130869495;2046.7441569803775;2049.1905697249576;2004.9799502005012;2011.2357304224374;2016.3346095788354;2035.6742921132623;2043.2133628552965;2014.6675798493231;2038.2458490358515;2040.622484840302;2043.6730123180294;2048.6517292060385;1933.6906095024729;1937.6996565532224;1938.621968716101;1942.7571553555806;1945.22191123551;1933.7969513201192;1959.3534133735834;1998.5003749062735;2004.148236999284;2005.6289586426558;7573.469857110004;7588.165301816795;7763.650635721406;7796.766097017098;7797.649105790253;4554.27131658933;4675.859724208279;4677.111348843709;4683.157031734287;4694.29585562165;2865;2933.88264469421;2986.044465770954;2990.6112205413156;2998.8800447982053;924.306769922558;932.9207017403529;947.1948843483053;950.2160717408166;952.514217748953;10433.895661043369;10559.894401056044;10590.788184236271;10651.414172220524;10663.786724265548;3976.8011599420493;3978.76127432355;4049.635532802003;4083.71414001023;4130.504339479222;9136.543172841331;9150.679726209552;9200.401973871676;9204.723858284262;9204.769880753034;4550.817967281272;4553.840615578439;4569.588737013618;4570.382998295254;4570.771461426915;3773.962260377416;3867.207222519377;3888.941665875014;4172.08214192877;4248.320268756984;3421.7091547218765;3469.9479507807405;3537.239493508908;3539.504469374238;3555.768875023115;1061.9628313009007;1081.967540973772;1085.8859819718973;1097.9945100274608;1104.6244276945877;745.9291367320096;769.1001528212006;780.8321210939675;783.142459007386;796.8645330293864;4854.781534830941;4973.626977976666;4989.17678583037;5020.723860187652;5107.821226257063;361.6708794996593;364.9817509124586;368.7621484142713;368.94281386385154;373.13432835821175;3269.558609587723;3549.6095429502734;3618.3667858124722;3642.1623026704005;3645.6172101929446;9079.863802042975;9511.33420660561;9534.332596718163;9534.570944307523;9536;9386.389884657476;9435.386699864624;9476.289278304155;9478.33651644392;9486.525673716425;6968.338007889242;6994.965025174842;7037.261087585832;7039.26087760788;7046.612436316052;4883.340748998982;4934.777934992862;4959.578435832995;4977.328060711902;5029.597632189343;8765.167309105625;8782.736517904474;8851.468911865051;8880.245179159843;8911.643534258557;8649.30805535543;8886.822263554563;8933.240674542736;8965.686200982935;9022.503762292874;6153.3538978408415;6691.665416729047;6721.731130754715;6748.223954245128;6766;6544.607323560602;7526.758084915928;7552.584607846621;7696.268854458817;7705.113911900204;6839.076724642109;6885.070515480546;6941.722331106699;7003.439724822104;7135.964320178366;6505.772297969548;6629.370209830058;6673.733050677918;6698.296678848846;6773.458123350219;5915.201447804491;6022.066579680157;6078.240219972504;6080.331163571915;6089.604175728564;4242.8727138185905;4289.356596510548;4318.244307246282;4363.425578908459;4386.035072284092;4193.622573968358;4290.12052529237;4355.825766969412;4377.693561450796;4435.933460998152 07:00:42 INFO - PROCESS | 2544 | |4;prototype.html;270.98238614490054;274.1241732664138;276.81523081212407;280.5791313030453;281.5860684793353;5231.73841307935;5237.30278906363;5238.947610523894;5246.842594722155;5251.737413129343;5174.353205849269;5177.896442071156;5181;5188.195829646402;5191.260927589253;3704.3702570563;3775.7734535927934;3802.277567262225;3878.0692633767835;3896.590857959916;3862.7682339059606;3870.7096967727534;3877.883663490086;3881.6700580450697;3882.320593896071;3837.750546214501;3853.2100919311474;3859.5947425520335;3866.149447121643;3879.1078052048047;3507;3675.375186218336;3744.9812750936344;3772.2391726433293;3780.735348525591;3293.884714034997;3295.8516866741056;3296.868125274986;3299.158714527804;3301.224212310105;5056.797728090872;5060.5951523878;5075.568576670988;5098.6176036797015;5111.284420181178;4303.33298338758;4344.652427805768;4403.772378516628;4411.161879242965;4525.140223357552;5354.866128346784;5358.544523715489;5376.892462150774;5377.193420986844;5379.892402151974;3578.731595130376;3614.5120408744747;3618.9095272618133;3635.509206257148;3641.271745650854;5563.777448902039;5603.327600687903;5606.607537472379;5776;5794.5074668653215;3667.7615954962844;3685.7788532688123;3707.8146092695256;3708.4808126862263;3721.1627383838418;3742.4386342048365;3755.3803622401997;3763.7741735495956;3769.227308401771;3817.2938006468894;4462.665300102505;4474.507804141542;4486.5962063414445;4491.944393067626;4496.707713998645;5167.793288268503;5484.287042684426;5485.259489968883;5490.450954904558;5492.395836457987;1285.5115056278742;1298.7142828577698;1299.4152631315947;1306.3598836570013;1307.5488956310057;769.2807225244414;796.7888509544975;797.2306724011357;804.9315808156372;812.7439856445201;5048.848534543896;5146;5223.13818219997;5273.758652572718;5279.815206467755;5686.46952106317;5687;5691.26013618227;5699.5155411790465;5703.17303990919;5015.398152221756;5197.8440646780655;5223;5266.657667251617;5286.577073834084;2965.9703402965692;2980.7317341438943;2996.5654980027775;3001.324701942089;3004.7145521175453;5711;5738.483536481736;5740.827775166752;5774.7449820663;5794.957647235151;5591.356993945748;5682.801101961411;5709.486146246858;5725.141228815711;5732.885342293131;5682.943170568324;5697.4587414195585;5707.8858422832145;5725.198472213977;5741.2536370273265;5418.431064738145;5546.251256080377;5602.467765562265;5649.604527683023;5698.971505142447;5469.890602187855;5485.01269771445;5510.448955104457;5516.172574113754;5561.416051314553;5723.713814309352;5744.626599271034;5771.249737534262;5783.306003279633;5805.506531944832;3784.4512545681273;3872.5546562145714;3876.546295139323;3878.8836334909997;3885.087004553871;5602.4957753802355;5604.103343465189;5604.523615492566;5608.9158662619275;5621.4659607337235;5527.364353099445;5531.197976293495;5545.112781954868;5550.694711790728;5554.722263886871;5291.497307755757;5387.222216668569;5431.864203394946;5450.754716037867;5467.289252397163;5367.463253674601;5374.435684253253;5389.353277606712;5403.4326395727885;5425.674459532441;5147.3308469898675;5304.6207985923165;5443.918341224806;5449.7275136243825;5488.765027868698;5366.838994830161;5409.350877894678;5431.728413579384;5437.32033495813;5465.453454654503 07:00:42 INFO - PROCESS | 2544 | |5;yui.html;651.2835880531414;729.4456213277908;740.5149626994317;741.9666115024824;746.1456632156181;13272.203667779928;13888.583342499742;14439.42242310309;14482.782758258621;14510;12862.099653024268;12896.1617494863;12912.160709553873;12914.225146491217;12915.870841291584;646.7833275852583;661.9834504137411;662.8508585568233;663.9302873198317;664.1996394344803;562.3252097483016;578.6412424296942;661.9106420633225;678.762433148399;682.7132604306179;705.675389320913;706.9787906362817;707.8548897476005;707.9575225486487;708.4509505133511;703.4372501998381;703.4688809948482;704.2886684448719;704.3519961635308;704.471646265301;430.6016934335727;438.87930819024706;501.49349157350974;509.7986295413291;516.4628786062491;12711.427985740664;13111.2133272004;13126.737465250737;13147.671308217276;13156.802647960289;11561.190716649839;11948.223365481215;12063.698407539881;12081.57714479989;12132.45403956824;10645.067978015633;10872.130229581615;10972.890271097267;11641.243319184226;11939.462724177432;3821.8649230111755;3907.7069219808627;3945.4081887716784;3978.6419222269847;4106.7125301228925;70842;71678;72005;72092;73005;9455.527223638928;9461.668841590648;9469.952650236704;9530.809383812284;9726.027397260359;16855.410060647817;16916.238769255167;16921.238544265536;16933.068681222652;16943.661126777395;7270.636468176675;7345.706171753177;7385.889211661829;7532.962335188289;7591.202923693043;3902.23906338267;3957.465742124834;4214.199302132585;4285.700000999963;4306.633936115465;2740.1642499037584;2815.042885418967;2816.9014084506944;2834.6881842997254;2839.4037252177272;492.6452953873206;498.9151844186497;502.86171302891995;517.6764522173642;522.334024119251;607.2197226563844;616.2420223125491;631.1290419221446;645.2225068792188;648.3322178156507;8469.618867150994;8704.477731336141;8777.824443511094;9020.64542390386;9206.907930920604;605.9182010428624;625.4621025917708;645.9580127291711;651.6513665189101;662.2251965200727;4126.834926602903;4243.745375277494;4309.892252693645;4321.567843215653;4333.609975102193;91407.54296228476;94490.52754736319;96860.51569742105;96967.51516242373;98690.50654746681;82006;82551.17448825555;84094;84662.57668711618;85826;70499.29500704927;71956.28043719496;73021.2697873025;73229.63385183146;73585.26414735892;7919.881201781863;8158.796030099057;8204.630791614272;8293.419460637697;8472.618732156945;41920.58079419289;43113.56886431095;43783.02447998217;43931;44869.775651121534;60522.394776051675;62978.68510657417;63433.365666344595;63680.3631963693;66570.66714666589;10236.18110551169;10372.170226382023;10453.947730261605;10599.89400105989;11161.051310638686;12301.569445069379;12451;12506.68733281639;12678.492860285485;12776;12902.483900643869;12977.805332919825;13082.542111026069;13219.735605288033;13596.048276620937;11389.316641001566;11628.18602697803;12272.631821045383;12708.745825083632;13308.534201302908;12087.214331068453;12974.091813572959;12974.675633109247;13068.281244531641;13178.341082946006;10403.583856645952;10463.79072418532;10645.148388128777;10981.61564345244;10982.890171098186;10351.585936562453;10394.22043346737;10441.269111162146;10563.63027294041;10604.098651614699 07:00:42 INFO - PROCESS | 2544 | __end_tp_report 07:00:42 INFO - PROCESS | 2544 | __start_cc_report 07:00:42 INFO - PROCESS | 2544 | _x_x_mozilla_cycle_collect,2237 07:00:42 INFO - PROCESS | 2544 | __end_cc_report 07:00:42 INFO - PROCESS | 2544 | __startTimestamp1477144842397__endTimestamp 07:00:42 INFO - PROCESS | 2544 | 07:00:42 INFO - PROCESS | 2544 | ------- Summary: start ------- 07:00:42 INFO - PROCESS | 2544 | Number of tests: 6 07:00:42 INFO - PROCESS | 2544 | 07:00:42 INFO - PROCESS | 2544 | [#0] dojo.html Cycles:165 Average:5170.84 Median:5482.81 stddev:690.55 (12.6%) stddev-sans-first:668.40 07:00:42 INFO - PROCESS | 2544 | Values: 2857.5 2876.4 2891.0 2911.7 2920.2 5138.2 5151.6 5155.9 5164.7 5239.2 5192.5 5251.9 5255.3 5270.4 5280.4 4726.7 4726.9 4737.4 4758.5 4803.3 4763.3 4781.9 4787.9 4795.7 4808.7 4621.0 4634.5 4666.3 4760.2 4763.9 4686.1 4691.9 4715.6 4723.0 4744.8 4592.2 4639.2 4653.1 4657.8 4760.9 4905.4 5192.0 5193.5 5198.5 5256.8 5586.8 5595.2 5612.2 5658.2 5658.3 5698.7 5713.9 5728.7 5744.6 5745.9 5055.2 5141.4 5201.3 5245.8 5281.2 5786.1 5806.1 5819.2 5824.2 5825.2 5520.8 5530.8 5549.6 5551.7 5562.1 5492.3 5557.2 5576.7 5584.2 5604.7 5582.2 5583.6 5592.2 5647.0 5667.2 5559.2 5569.2 5585.1 5603.8 5628.5 3769.1 3825.9 3833.0 3836.5 3866.7 3296.9 3314.1 3330.0 3346.3 3350.2 5237.8 5242.6 5249.8 5253.5 5258.6 5624.7 5648.6 5656.7 5660.8 5680.6 5148.6 5181.5 5244.2 5245.6 5247.1 4558.6 4573.2 4626.0 4629.2 4632.9 5760.5 5781.5 5782.6 5783.9 5790.2 5568.5 5651.9 5654.7 5674.7 5768.4 5726.4 5737.7 5769.1 5774.2 5798.4 5566.4 5568.5 5596.6 5609.1 5647.5 5664.1 5675.0 5699.1 5709.7 5712.3 5359.1 5471.8 5472.6 5553.3 5555.4 5540.2 5543.1 5545.8 5547.2 5549.4 5415.5 5462.2 5475.9 5482.8 5488.0 5518.1 5549.6 5572.3 5573.0 5587.6 5467.1 5496.7 5505.8 5517.7 5518.3 07:00:42 INFO - PROCESS | 2544 | 07:00:42 INFO - PROCESS | 2544 | [#1] ext.html Cycles:180 Average:48704.17 Median:19905.79 stddev:94784.81 (476.2%) stddev-sans-first:94981.77 07:00:42 INFO - PROCESS | 2544 | Values: 554.8 570.9 575.8 581.8 583.4 28307.4 37487.6 38630.8 38706.4 40865.4 40348.6 40619.0 40631.4 40863.2 40919.6 8437.8 8562.2 8596.6 8603.7 8609.0 8400.4 8474.4 8484.5 8499.6 8503.8 8464.1 8479.7 8505.6 8515.7 8515.8 8442.5 8457.0 8484.6 8493.8 8497.5 8388.5 8400.1 8448.5 8459.3 8464.7 37479.4 37756.4 37829.8 37876.0 37890.2 3130.0 3353.1 3438.3 3556.7 3600.8 29411.0 29550.9 29919.6 30029.4 30558.4 3966.8 3969.0 3996.4 4017.0 4109.0 279751.0 280036.0 280864.0 281088.7 281558.0 28953.6 49484.5 49569.0 49808.3 49896.5 29854.6 31756.0 31812.4 31903.7 31923.2 14065.5 14080.9 14195.9 14213.9 14214.0 11347.9 11374.0 11393.6 11426.7 11476.7 7029.9 7149.6 7201.9 7233.2 7243.9 2798.4 2825.7 2832.0 2862.0 2865.4 825.3 859.0 879.8 922.1 945.0 27565.7 27782.0 27850.3 27955.3 27962.0 940.7 959.9 967.7 1007.5 1048.2 14175.8 14230.4 14851.1 14883.1 14971.9 449405.0 451151.0 452812.0 453111.0 453329.0 50184.7 50255.0 50486.0 50584.7 50606.0 1101.6 1115.8 1163.7 1192.1 1204.7 28207.0 28505.7 28775.3 28992.3 29037.1 42814.4 43691.3 43753.8 43785.3 43928.8 313664.0 314561.0 318977.0 319648.0 321089.0 21612.2 22348.8 23429.4 24787.3 25736.6 40547.8 41080.8 41116.4 41193.0 41599.2 35134.8 35672.0 35787.6 36226.0 36317.0 35465.6 35776.3 35907.1 35924.8 36210.8 33435.8 34033.3 34063.0 34393.7 34516.5 30872.5 32280.5 32323.4 32374.5 32534.0 23993.0 24248.0 24295.6 24385.0 24448.4 07:00:42 INFO - PROCESS | 2544 | 07:00:42 INFO - PROCESS | 2544 | [#2] jquery.html Cycles:180 Average:24313.64 Median:5299.77 stddev:67424.18 (1272.2%) stddev-sans-first:67589.28 07:00:42 INFO - PROCESS | 2544 | Values: 332.5 335.6 336.8 346.3 354.1 16176.7 16820.5 17398.8 17582.6 17740.3 9892.0 9933.0 9965.9 9993.1 10007.1 4697.1 4759.6 4804.3 4804.6 4806.9 4972.8 5204.8 5240.8 5318.9 5319.5 5285.4 5294.7 5299.4 5300.2 5302.5 5491.3 5768.4 5806.8 5813.1 5816.2 4510.9 5107.6 5120.7 5123.5 5132.9 10279.0 11226.3 11249.7 11251.5 11258.4 1962.5 1973.9 1980.9 2000.7 2058.9 7948.6 7955.6 8177.4 8197.8 8242.4 1676.7 1705.5 1719.7 1749.8 1778.1 73727.6 73909.6 74261.6 75248.2 75291.6 9084.5 9130.8 9220.1 9243.6 9407.3 12452.7 12489.2 12560.9 12607.7 12616.9 6924.3 7161.4 7200.4 7209.4 7349.9 7221.5 7296.6 7321.4 7323.6 7424.6 3751.8 3772.4 3785.9 3786.8 3821.0 1578.6 1611.2 1625.6 1654.7 1658.8 789.7 800.5 855.9 871.5 930.0 16399.1 16495.8 16511.9 17001.2 17246.7 815.2 830.5 842.9 874.1 888.1 9026.7 9174.2 9221.0 9359.9 9424.4 401087.0 402425.0 405751.0 410730.0 413269.0 82048.0 83533.6 84956.0 85335.6 86956.0 879.6 884.2 895.1 896.5 897.0 14671.9 14750.4 14753.3 15121.5 15325.1 30462.8 34729.5 35642.8 35669.5 37232.3 46954.8 49464.0 49756.8 50068.2 50964.5 7024.3 7100.9 7190.9 7198.9 7222.7 8928.6 11102.7 11395.5 11544.8 11744.9 8477.2 9092.4 9821.0 9885.8 10129.9 9791.8 9854.8 9924.7 10222.5 10328.3 9626.1 9661.9 9703.3 9878.6 9909.5 6900.2 6969.9 7082.3 7095.6 7316.2 6960.6 9696.3 9763.0 10228.5 10766.7 07:00:42 INFO - PROCESS | 2544 | 07:00:42 INFO - PROCESS | 2544 | [#3] mootools.html Cycles:180 Average:5007.61 Median:4869.06 stddev:2896.47 (59.5%) stddev-sans-first:2890.49 07:00:42 INFO - PROCESS | 2544 | Values: 1204.3 1272.7 1305.0 1319.9 1541.3 6759.0 7422.6 7695.7 7701.2 7711.8 7465.9 7636.5 7638.1 7777.7 7807.0 2012.1 2043.2 2044.8 2046.7 2049.2 2005.0 2011.2 2016.3 2035.7 2043.2 2014.7 2038.2 2040.6 2043.7 2048.7 1933.7 1937.7 1938.6 1942.8 1945.2 1933.8 1959.4 1998.5 2004.1 2005.6 7573.5 7588.2 7763.7 7796.8 7797.6 4554.3 4675.9 4677.1 4683.2 4694.3 2865.0 2933.9 2986.0 2990.6 2998.9 924.3 932.9 947.2 950.2 952.5 10433.9 10559.9 10590.8 10651.4 10663.8 3976.8 3978.8 4049.6 4083.7 4130.5 9136.5 9150.7 9200.4 9204.7 9204.8 4550.8 4553.8 4569.6 4570.4 4570.8 3774.0 3867.2 3888.9 4172.1 4248.3 3421.7 3469.9 3537.2 3539.5 3555.8 1062.0 1082.0 1085.9 1098.0 1104.6 745.9 769.1 780.8 783.1 796.9 4854.8 4973.6 4989.2 5020.7 5107.8 361.7 365.0 368.8 368.9 373.1 3269.6 3549.6 3618.4 3642.2 3645.6 9079.9 9511.3 9534.3 9534.6 9536.0 9386.4 9435.4 9476.3 9478.3 9486.5 6968.3 6995.0 7037.3 7039.3 7046.6 4883.3 4934.8 4959.6 4977.3 5029.6 8765.2 8782.7 8851.5 8880.2 8911.6 8649.3 8886.8 8933.2 8965.7 9022.5 6153.4 6691.7 6721.7 6748.2 6766.0 6544.6 7526.8 7552.6 7696.3 7705.1 6839.1 6885.1 6941.7 7003.4 7136.0 6505.8 6629.4 6673.7 6698.3 6773.5 5915.2 6022.1 6078.2 6080.3 6089.6 4242.9 4289.4 4318.2 4363.4 4386.0 4193.6 4290.1 4355.8 4377.7 4435.9 07:00:42 INFO - PROCESS | 2544 | 07:00:42 INFO - PROCESS | 2544 | [#4] prototype.html Cycles:180 Average:4514.58 Median:5242.90 stddev:1402.41 (26.7%) stddev-sans-first:1369.70 07:00:42 INFO - PROCESS | 2544 | Values: 271.0 274.1 276.8 280.6 281.6 5231.7 5237.3 5238.9 5246.8 5251.7 5174.4 5177.9 5181.0 5188.2 5191.3 3704.4 3775.8 3802.3 3878.1 3896.6 3862.8 3870.7 3877.9 3881.7 3882.3 3837.8 3853.2 3859.6 3866.1 3879.1 3507.0 3675.4 3745.0 3772.2 3780.7 3293.9 3295.9 3296.9 3299.2 3301.2 5056.8 5060.6 5075.6 5098.6 5111.3 4303.3 4344.7 4403.8 4411.2 4525.1 5354.9 5358.5 5376.9 5377.2 5379.9 3578.7 3614.5 3618.9 3635.5 3641.3 5563.8 5603.3 5606.6 5776.0 5794.5 3667.8 3685.8 3707.8 3708.5 3721.2 3742.4 3755.4 3763.8 3769.2 3817.3 4462.7 4474.5 4486.6 4491.9 4496.7 5167.8 5484.3 5485.3 5490.5 5492.4 1285.5 1298.7 1299.4 1306.4 1307.5 769.3 796.8 797.2 804.9 812.7 5048.8 5146.0 5223.1 5273.8 5279.8 5686.5 5687.0 5691.3 5699.5 5703.2 5015.4 5197.8 5223.0 5266.7 5286.6 2966.0 2980.7 2996.6 3001.3 3004.7 5711.0 5738.5 5740.8 5774.7 5795.0 5591.4 5682.8 5709.5 5725.1 5732.9 5682.9 5697.5 5707.9 5725.2 5741.3 5418.4 5546.3 5602.5 5649.6 5699.0 5469.9 5485.0 5510.4 5516.2 5561.4 5723.7 5744.6 5771.2 5783.3 5805.5 3784.5 3872.6 3876.5 3878.9 3885.1 5602.5 5604.1 5604.5 5608.9 5621.5 5527.4 5531.2 5545.1 5550.7 5554.7 5291.5 5387.2 5431.9 5450.8 5467.3 5367.5 5374.4 5389.4 5403.4 5425.7 5147.3 5304.6 5443.9 5449.7 5488.8 5366.8 5409.4 5431.7 5437.3 5465.5 07:00:42 INFO - PROCESS | 2544 | 07:00:42 INFO - PROCESS | 2544 | [#5] yui.html Cycles:180 Average:18011.08 Median:44400.39 stddev:25505.34 (57.4%) stddev-sans-first:25543.58 07:00:42 INFO - PROCESS | 2544 | Values: 651.3 729.4 740.5 742.0 746.1 13272.2 13888.6 14439.4 14482.8 14510.0 12862.1 12896.2 12912.2 12914.2 12915.9 646.8 662.0 662.9 663.9 664.2 562.3 578.6 661.9 678.8 682.7 705.7 707.0 707.9 708.0 708.5 703.4 703.5 704.3 704.4 704.5 430.6 438.9 501.5 509.8 516.5 12711.4 13111.2 13126.7 13147.7 13156.8 11561.2 11948.2 12063.7 12081.6 12132.5 10645.1 10872.1 10972.9 11641.2 11939.5 3821.9 3907.7 3945.4 3978.6 4106.7 70842.0 71678.0 72005.0 72092.0 73005.0 9455.5 9461.7 9470.0 9530.8 9726.0 16855.4 16916.2 16921.2 16933.1 16943.7 7270.6 7345.7 7385.9 7533.0 7591.2 3902.2 3957.5 4214.2 4285.7 4306.6 2740.2 2815.0 2816.9 2834.7 2839.4 492.6 498.9 502.9 517.7 522.3 607.2 616.2 631.1 645.2 648.3 8469.6 8704.5 8777.8 9020.6 9206.9 605.9 625.5 646.0 651.7 662.2 4126.8 4243.7 4309.9 4321.6 4333.6 91407.5 94490.5 96860.5 96967.5 98690.5 82006.0 82551.2 84094.0 84662.6 85826.0 70499.3 71956.3 73021.3 73229.6 73585.3 7919.9 8158.8 8204.6 8293.4 8472.6 41920.6 43113.6 43783.0 43931.0 44869.8 60522.4 62978.7 63433.4 63680.4 66570.7 10236.2 10372.2 10453.9 10599.9 11161.1 12301.6 12451.0 12506.7 12678.5 12776.0 12902.5 12977.8 13082.5 13219.7 13596.0 11389.3 11628.2 12272.6 12708.7 13308.5 12087.2 12974.1 12974.7 13068.3 13178.3 10403.6 10463.8 10645.1 10981.6 10982.9 10351.6 10394.2 10441.3 10563.6 10604.1 07:00:42 INFO - PROCESS | 2544 | -------- Summary: end -------- 07:00:42 INFO - PROCESS | 2544 | 07:00:43 INFO - TEST-INFO | 2544: exit 0 07:00:43 INFO - TEST-OK | dromaeo_css | took 1121680ms 07:00:43 INFO - TEST-START | kraken 07:00:43 INFO - operating with platform_type : w8_ 07:00:43 INFO - Initialising browser for kraken test... 07:00:43 INFO - TEST-INFO | started process 3676 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdevy_d\profile http://localhost:49288/getInfo.html) 07:00:49 INFO - PROCESS | 3676 | __metrics Screen width/height:1600/1200 07:00:49 INFO - PROCESS | 3676 | colorDepth:24 07:00:49 INFO - PROCESS | 3676 | Browser inner width/height: 1010/674 07:00:49 INFO - PROCESS | 3676 | __metrics 07:00:50 INFO - PROCESS | 3676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:00:50 INFO - PROCESS | 3676 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:00:50 INFO - PROCESS | 3676 | console.error: 07:00:50 INFO - PROCESS | 3676 | Message: Error: Connection closed before committing the transaction. 07:00:50 INFO - PROCESS | 3676 | Stack: 07:00:50 INFO - PROCESS | 3676 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 07:00:50 INFO - PROCESS | 3676 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 07:00:50 INFO - PROCESS | 3676 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 07:00:50 INFO - PROCESS | 3676 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 07:00:50 INFO - PROCESS | 3676 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 07:00:50 INFO - PROCESS | 3676 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 07:00:50 INFO - PROCESS | 3676 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 07:00:50 INFO - PROCESS | 3676 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 07:00:50 INFO - PROCESS | 3676 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 07:00:50 INFO - PROCESS | 3676 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 07:00:50 INFO - PROCESS | 3676 | Barrier/this.client.addBlocker/promise13.3% 07:01:47 INFO - TinderboxPrint: I/O read bytes / time
45,678,592 / 467,030 07:01:47 INFO - TinderboxPrint: I/O write bytes / time
409,361,408 / 3,209,510 07:01:47 INFO - TinderboxPrint: CPU idle
8,260.5 (86.7%) 07:01:47 INFO - TinderboxPrint: CPU user
1,220.5 (12.8%) 07:01:47 INFO - install - Wall time: 3s; CPU: 12.0%; Read bytes: 0; Write bytes: 34579456; Read time: 0; Write time: 74680 07:01:47 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 45678592; Write bytes: 318116864; Read time: 467030; Write time: 3084140 07:01:47 INFO - Running post-run listener: _upload_blobber_files 07:01:47 INFO - Blob upload gear active. 07:01:47 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 07:01:47 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 07:01:47 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', 'Firefox', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 07:01:47 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 Firefox -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 07:01:48 INFO - (blobuploader) - INFO - Open directory for files ... 07:01:48 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 07:01:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:01:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:49 INFO - (blobuploader) - INFO - Done attempting. 07:01:49 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 07:01:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:01:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:50 INFO - (blobuploader) - INFO - Done attempting. 07:01:50 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 07:01:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:01:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:52 INFO - (blobuploader) - INFO - Done attempting. 07:01:52 INFO - (blobuploader) - INFO - Iteration through files over. 07:01:52 INFO - Return code: 0 07:01:52 INFO - rmtree: C:\slave\test\build\uploaded_files.json 07:01:52 INFO - Using _rmtree_windows ... 07:01:52 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 07:01:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ea9019c13260bb543eccd45706d25b22ca9ea37fb7dc8eb714ec0bb6895289c5243d14ab04d54bdc10200d4eb77933c36a9b1347ba425b35994f497972ff2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/578bd106841ee12c3ed4094af5e7eff04bdbdb231be91b4eb121a9855540ae5ed8f15a9c34f9c08b716a754e6366d82f855f2142d7333cef8d98c0532c71f5e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9d34d34d80b3374c043bbed277d0d13652fe6747fa4f03c2c1f495270e2ae7b7045ca83e95fac760e4c07b2c6591dfb6e7ec590f8248cafe82749d5c64464a0"} 07:01:52 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 07:01:52 INFO - Writing to file C:\slave\test\properties\blobber_files 07:01:52 INFO - Contents: 07:01:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ea9019c13260bb543eccd45706d25b22ca9ea37fb7dc8eb714ec0bb6895289c5243d14ab04d54bdc10200d4eb77933c36a9b1347ba425b35994f497972ff2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/578bd106841ee12c3ed4094af5e7eff04bdbdb231be91b4eb121a9855540ae5ed8f15a9c34f9c08b716a754e6366d82f855f2142d7333cef8d98c0532c71f5e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9d34d34d80b3374c043bbed277d0d13652fe6747fa4f03c2c1f495270e2ae7b7045ca83e95fac760e4c07b2c6591dfb6e7ec590f8248cafe82749d5c64464a0"} 07:01:52 INFO - Running post-run listener: copy_logs_to_upload_dir 07:01:52 INFO - Copying logs to upload dir... 07:01:52 INFO - mkdir: C:\slave\test\build\upload\logs 07:01:52 INFO - Copying logs to upload dir... 07:01:52 INFO - Using _rmtree_windows ... 07:01:52 INFO - Using _rmtree_windows ... 07:01:52 INFO - Using _rmtree_windows ... 07:01:52 INFO - Using _rmtree_windows ... 07:01:52 INFO - Using _rmtree_windows ... 07:01:52 INFO - Using _rmtree_windows ... 07:01:52 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1379.602000 ========= master_lag: 0.06 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 59 secs) (at 2016-10-22 07:01:52.635892) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 07:01:52.636721) ========= '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/Firefox/sha512/51ea9019c13260bb543eccd45706d25b22ca9ea37fb7dc8eb714ec0bb6895289c5243d14ab04d54bdc10200d4eb77933c36a9b1347ba425b35994f497972ff2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/578bd106841ee12c3ed4094af5e7eff04bdbdb231be91b4eb121a9855540ae5ed8f15a9c34f9c08b716a754e6366d82f855f2142d7333cef8d98c0532c71f5e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9d34d34d80b3374c043bbed277d0d13652fe6747fa4f03c2c1f495270e2ae7b7045ca83e95fac760e4c07b2c6591dfb6e7ec590f8248cafe82749d5c64464a0"} build_url:https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/NeVGdzdMSFe8HsPnfNAndw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ea9019c13260bb543eccd45706d25b22ca9ea37fb7dc8eb714ec0bb6895289c5243d14ab04d54bdc10200d4eb77933c36a9b1347ba425b35994f497972ff2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/578bd106841ee12c3ed4094af5e7eff04bdbdb231be91b4eb121a9855540ae5ed8f15a9c34f9c08b716a754e6366d82f855f2142d7333cef8d98c0532c71f5e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9d34d34d80b3374c043bbed277d0d13652fe6747fa4f03c2c1f495270e2ae7b7045ca83e95fac760e4c07b2c6591dfb6e7ec590f8248cafe82749d5c64464a0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 07:01:52.763615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 07:01:52.764000) ========= '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-10-22 07:01:52.886205) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-22 07:01:52.886517) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-22 07:01:53.369188) ========= ========= Total master_lag: 0.24 =========