builder: autoland_win8_64_test-dromaeojs-pgo slave: t-w864-ix-208 starttime: 1477538744.32 results: success (0) buildid: 20161026174805 builduid: e09c4e3d9a5e433aaa4077a10fae2e8e revision: 532415dbd6208ff854e65760f5ea9241de4edd7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 20:25:44.323425) ========= master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 20:25:44.323801) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 20:25:44.324088) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 20:25:44.517321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-10-26 20:25:44.517696) ========= '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-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --20:25:45-- 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% 1.64 GB/s 20:25:46 (1.64 GB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.698000 ========= master_lag: 3.79 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-10-26 20:25:50.004353) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-26 20:25:50.004696) ========= '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-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=3.515000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-26 20:25:53.543817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 20:25:53.544734) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/autoland --rev 532415dbd6208ff854e65760f5ea9241de4edd7b --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 532415dbd6208ff854e65760f5ea9241de4edd7b --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-26 20:25:54,431 truncating revision to first 12 chars 2016-10-26 20:25:54,431 Setting DEBUG logging. 2016-10-26 20:25:54,431 attempt 1/10 2016-10-26 20:25:54,431 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/532415dbd620?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 20:25:54,915 unpacking tar archive at: autoland-532415dbd620/testing/mozharness/ 2016-10-26 20:25:55,015 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.529000 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 20:25:55.120391) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 20:25:55.120715) ========= script_repo_revision: 532415dbd6208ff854e65760f5ea9241de4edd7b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 20:25:55.121109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 20:25:55.121377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 20:25:55.138915) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 8 secs) (at 2016-10-26 20:25:55.139205) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Autoland' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Autoland' 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', 'Autoland', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 20:25:55 INFO - MultiFileLogger online at 20161026 20:25:55 in C:\slave\test 20:25:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 20:25:55 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 20:25:55 INFO - {'append_to_log': False, 20:25:55 INFO - 'base_work_dir': 'C:\\slave\\test', 20:25:55 INFO - 'blob_upload_branch': 'Autoland', 20:25:55 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 20:25:55 INFO - 'branch': 'Autoland', 20:25:55 INFO - 'buildbot_json_path': 'buildprops.json', 20:25:55 INFO - 'config_files': ('talos/windows_config.py',), 20:25:55 INFO - 'default_actions': ('clobber', 20:25:55 INFO - 'read-buildbot-config', 20:25:55 INFO - 'download-and-extract', 20:25:55 INFO - 'populate-webroot', 20:25:55 INFO - 'create-virtualenv', 20:25:55 INFO - 'install', 20:25:55 INFO - 'run-tests'), 20:25:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:25:55 INFO - 'download_minidump_stackwalk': True, 20:25:55 INFO - 'download_symbols': 'ondemand', 20:25:55 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 20:25:55 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 20:25:55 INFO - 'hg': 'c:/mozilla-build/hg/hg', 20:25:55 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 20:25:55 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 20:25:55 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 20:25:55 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 20:25:55 INFO - 'C:/mozilla-build/tooltool.py'), 20:25:55 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 20:25:55 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 20:25:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:25:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:25:55 INFO - 'installer_path': 'installer.exe', 20:25:55 INFO - 'log_level': 'info', 20:25:55 INFO - 'log_name': 'talos', 20:25:55 INFO - 'log_to_console': True, 20:25:55 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 20:25:55 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 20:25:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 20:25:55 INFO - 'opt_config_files': (), 20:25:55 INFO - 'pip_index': False, 20:25:55 INFO - 'sps_profile': False, 20:25:55 INFO - 'sps_profile_interval': 0, 20:25:55 INFO - 'suite': 'dromaeojs', 20:25:55 INFO - 'system_bits': '32', 20:25:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:25:55 INFO - 'title': 'T-W864-IX-208', 20:25:55 INFO - 'use_talos_json': True, 20:25:55 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 20:25:55 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 20:25:55 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 20:25:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:25:55 INFO - 'work_dir': 'build'} 20:25:55 INFO - [mozharness: 2016-10-27 03:25:55.805000Z] Running clobber step. 20:25:55 INFO - Running pre-action listener: _resource_record_pre_action 20:25:55 INFO - Running main action method: clobber 20:25:55 INFO - rmtree: C:\slave\test\build 20:25:55 INFO - Using _rmtree_windows ... 20:25:55 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 20:27:29 INFO - Running post-action listener: _resource_record_post_action 20:27:29 INFO - [mozharness: 2016-10-27 03:27:29.286000Z] Finished clobber step (success) 20:27:29 INFO - [mozharness: 2016-10-27 03:27:29.286000Z] Running read-buildbot-config step. 20:27:29 INFO - Running pre-action listener: _resource_record_pre_action 20:27:29 INFO - Running main action method: read_buildbot_config 20:27:29 INFO - Using buildbot properties: 20:27:29 INFO - { 20:27:29 INFO - "project": "", 20:27:29 INFO - "product": "firefox", 20:27:29 INFO - "script_repo_revision": "production", 20:27:29 INFO - "builddir": "autoland_win8_64_test-dromaeojs", 20:27:29 INFO - "repository": "", 20:27:29 INFO - "buildername": "Windows 8 64-bit autoland pgo talos dromaeojs", 20:27:29 INFO - "buildid": "20161026174805", 20:27:29 INFO - "pgo_build": "True", 20:27:29 INFO - "basedir": "C:\\slave\\test", 20:27:29 INFO - "buildnumber": 87, 20:27:29 INFO - "slavename": "t-w864-ix-208", 20:27:29 INFO - "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/", 20:27:29 INFO - "platform": "win8_64", 20:27:29 INFO - "scheduler": "tests-autoland-win64-pgo-talos", 20:27:29 INFO - "branch": "autoland", 20:27:29 INFO - "repo_path": "integration/autoland", 20:27:29 INFO - "revision": "532415dbd6208ff854e65760f5ea9241de4edd7b", 20:27:29 INFO - "stage_platform": "win64-pgo", 20:27:29 INFO - "builduid": "e09c4e3d9a5e433aaa4077a10fae2e8e", 20:27:29 INFO - "slavebuilddir": "test" 20:27:29 INFO - } 20:27:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 20:27:29 INFO - Running post-action listener: _resource_record_post_action 20:27:29 INFO - [mozharness: 2016-10-27 03:27:29.289000Z] Finished read-buildbot-config step (success) 20:27:29 INFO - [mozharness: 2016-10-27 03:27:29.290000Z] Running download-and-extract step. 20:27:29 INFO - Running pre-action listener: _resource_record_pre_action 20:27:29 INFO - Running main action method: download_and_extract 20:27:29 INFO - mkdir: C:\slave\test\build\tests 20:27: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')]} 20:27:29 INFO - trying https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 20:27:29 INFO - Downloading https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/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 20:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/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 20:27:30 INFO - Downloaded 1218 bytes. 20:27:30 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 20:27:30 INFO - Using the following test package requirements: 20:27:30 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 20:27:30 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:27:30 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 20:27:30 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 20:27:30 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:27:30 INFO - u'jsshell-win64.zip'], 20:27:30 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:27:30 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 20:27:30 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 20:27:30 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:27:30 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 20:27:30 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:27:30 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 20:27:30 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:27:30 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 20:27:30 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:27:30 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 20:27:30 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 20:27:30 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 20:27:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 20:27:30 INFO - Fetch https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 20:27:30 INFO - Http code: 200 20:27:30 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 20:27:30 INFO - x-amz-cf-id: -uP1J8IsvvBzntIzHm99aUemWydD15Nps3h-_1kzNAxT_CE-mFj17w== 20:27:30 INFO - x-amz-version-id: t_.Qb32kBCAtrjZ8gr3adLW.i0.zAZqU 20:27:31 INFO - Expected file size: 17416601 20:27:31 INFO - Obtained file size: 17416601 20:27:56 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 20:27:56 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 20:27:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 20:27:56 INFO - Fetch https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 20:27:57 INFO - Http code: 200 20:27:57 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 20:27:57 INFO - x-amz-cf-id: XGBNzn1CI3ZGr_5BcRCb9-Vrey-----3jNW9Kkc0iltaxZxHh_HHCA== 20:27:57 INFO - x-amz-version-id: t_.Qb32kBCAtrjZ8gr3adLW.i0.zAZqU 20:27:57 INFO - Expected file size: 17416601 20:27:57 INFO - Obtained file size: 17416601 20:28:06 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 20:28:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 20:28:06 INFO - Fetch https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 20:28:07 INFO - Http code: 200 20:28:07 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 20:28:07 INFO - x-amz-cf-id: Nikt76L7dLc7cbGfwGYSErt2xGH1OTM3ij8owZPUo_rCSYUXfY2v-Q== 20:28:07 INFO - x-amz-version-id: HvU1DAKsU6W1Ezx_ICdMPZYRHfFSvGPC 20:28:07 INFO - Expected file size: 14409028 20:28:07 INFO - Obtained file size: 14409028 20:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:13 INFO - trying https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 20:28:13 INFO - Downloading https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 20:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/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 20:28:14 INFO - Downloaded 57068526 bytes. 20:28:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 20:28:14 INFO - mkdir: C:\slave\test\properties 20:28:14 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 20:28:14 INFO - Writing to file C:\slave\test\properties\build_url 20:28:14 INFO - Contents: 20:28:14 INFO - build_url:https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 20:28:15 INFO - Running post-action listener: _resource_record_post_action 20:28:15 INFO - Running post-action listener: set_extra_try_arguments 20:28:15 INFO - [mozharness: 2016-10-27 03:28:15.663000Z] Finished download-and-extract step (success) 20:28:15 INFO - [mozharness: 2016-10-27 03:28:15.663000Z] Running populate-webroot step. 20:28:15 INFO - Running pre-action listener: _resource_record_pre_action 20:28:15 INFO - Running main action method: populate_webroot 20:28:15 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 20:28:15 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 20:28:15 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 20:28:15 INFO - u'--tppagecycles', 20:28:15 INFO - u'7'], 20:28:15 INFO - u'tests': [u'tsvgm']}}, 20:28:15 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 20:28:15 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 20:28:15 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 20:28:15 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 20:28:15 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 20:28:15 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 20:28:15 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:15 INFO - u'talos_options': [u'--disable-e10s'], 20:28:15 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 20:28:15 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:15 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 20:28:15 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:15 INFO - u'talos_options': [u'--disable-e10s'], 20:28:15 INFO - u'tests': [u'damp', u'tps']}, 20:28:15 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:15 INFO - u'tests': [u'damp', u'tps']}, 20:28:15 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 20:28:15 INFO - u'tests': [u'dromaeo_dom']}, 20:28:15 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 20:28:15 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 20:28:15 INFO - u'tests': [u'basic_compositor_video']}, 20:28:15 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 20:28:15 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 20:28:15 INFO - u'tests': [u'a11yr', 20:28:15 INFO - u'ts_paint', 20:28:15 INFO - u'tpaint', 20:28:15 INFO - u'sessionrestore', 20:28:15 INFO - u'sessionrestore_no_auto_restore', 20:28:15 INFO - u'tabpaint']}, 20:28:15 INFO - u'other-e10s': {u'tests': [u'a11yr', 20:28:15 INFO - u'ts_paint', 20:28:15 INFO - u'tpaint', 20:28:15 INFO - u'sessionrestore', 20:28:15 INFO - u'sessionrestore_no_auto_restore', 20:28:15 INFO - u'tabpaint']}, 20:28:15 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 20:28:15 INFO - u'ts_paint', 20:28:15 INFO - u'tpaint', 20:28:15 INFO - u'sessionrestore', 20:28:15 INFO - u'sessionrestore_no_auto_restore', 20:28:15 INFO - u'tabpaint']}, 20:28:15 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 20:28:15 INFO - u'ts_paint', 20:28:15 INFO - u'tpaint', 20:28:15 INFO - u'sessionrestore', 20:28:15 INFO - u'sessionrestore_no_auto_restore', 20:28:15 INFO - u'tabpaint']}, 20:28:15 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 20:28:15 INFO - u'tests': [u'a11yr', 20:28:15 INFO - u'ts_paint', 20:28:15 INFO - u'tpaint', 20:28:15 INFO - u'sessionrestore', 20:28:15 INFO - u'sessionrestore_no_auto_restore', 20:28:15 INFO - u'tabpaint']}, 20:28:15 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 20:28:15 INFO - u'tests': [u'a11yr', 20:28:15 INFO - u'ts_paint', 20:28:15 INFO - u'tpaint', 20:28:15 INFO - u'sessionrestore', 20:28:15 INFO - u'sessionrestore_no_auto_restore', 20:28:15 INFO - u'tabpaint']}, 20:28:15 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 20:28:15 INFO - u'tests': [u'tsvgx', 20:28:15 INFO - u'tsvgr_opacity', 20:28:15 INFO - u'tart', 20:28:15 INFO - u'tscrollx', 20:28:15 INFO - u'cart']}, 20:28:15 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 20:28:15 INFO - u'tsvgr_opacity', 20:28:15 INFO - u'tart', 20:28:15 INFO - u'tscrollx', 20:28:15 INFO - u'cart']}, 20:28:15 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:15 INFO - u'talos_options': [u'--disable-e10s'], 20:28:15 INFO - u'tests': [u'tp5o']}, 20:28:15 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:15 INFO - u'tests': [u'tp5o']}, 20:28:15 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:15 INFO - u'talos_options': [u'--disable-e10s', 20:28:15 INFO - u'--xperf_path', 20:28:15 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:15 INFO - u'tests': [u'tp5n']}, 20:28:15 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:15 INFO - u'talos_options': [u'--xperf_path', 20:28:15 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:15 INFO - u'tests': [u'tp5n']}}, 20:28:15 INFO - u'talos.zip': {u'path': u'', 20:28:15 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:28:15 INFO - Running post-action listener: _resource_record_post_action 20:28:15 INFO - [mozharness: 2016-10-27 03:28:15.755000Z] Finished populate-webroot step (success) 20:28:15 INFO - [mozharness: 2016-10-27 03:28:15.755000Z] Running create-virtualenv step. 20:28:15 INFO - Running pre-action listener: _resource_record_pre_action 20:28:15 INFO - Running main action method: create_virtualenv 20:28:15 INFO - Creating virtualenv C:\slave\test\build/venv 20:28:15 INFO - mkdir: C:\slave\test\build\venv\Scripts 20:28:16 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 20:28:16 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'! 20:28:16 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 20:28:16 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 20:28:26 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 20:28:29 INFO - Installing distribute......................................................................................................................................................................................done. 20:28:30 INFO - Return code: 0 20:28:30 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 20:28:30 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 20:28:31 INFO - Reading from file tmpfile_stdout 20:28:31 INFO - Output received: 20:28:31 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 20:28:31 INFO - Using _rmtree_windows ... 20:28:31 INFO - Using _rmtree_windows ... 20:28:31 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 20:28: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')]} 20:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28: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')]} 20:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02293E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DAE90>, '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 0x01C8A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 20:28: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', 'pip>=1.5'] in C:\slave\test\build 20:28: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 pip>=1.5 20:28:31 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:28:31 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 20:28:31 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:28:31 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:28:31 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:28:31 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 20:28:31 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:28:31 INFO - 'DCLOCATION': 'SCL3', 20:28:31 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:28:31 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:28:31 INFO - 'HOMEDRIVE': 'C:', 20:28:31 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 20:28:31 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:28:31 INFO - 'KTS_VERSION': '1.19c', 20:28:31 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 20:28:31 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 20:28:31 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:28:31 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:31 INFO - 'MOZ_NO_REMOTE': '1', 20:28:31 INFO - 'NO_EM_RESTART': '1', 20:28:31 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:28:31 INFO - 'OS': 'Windows_NT', 20:28:31 INFO - 'OURDRIVE': 'C:', 20:28: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', 20:28:31 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:28:31 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:28:31 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:28:31 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:28:31 INFO - 'PROCESSOR_LEVEL': '6', 20:28:31 INFO - 'PROCESSOR_REVISION': '1e05', 20:28:31 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:28:31 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:28:31 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:28:31 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:28:31 INFO - 'PROMPT': '$P$G', 20:28:31 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:28:31 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:28:31 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:28:31 INFO - 'PWD': 'C:\\slave\\test', 20:28:31 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:28:31 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:28:31 INFO - 'SYSTEMDRIVE': 'C:', 20:28:31 INFO - 'SYSTEMROOT': 'C:\\windows', 20:28:31 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:31 INFO - 'TEST1': 'testie', 20:28:31 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:31 INFO - 'USERDOMAIN': 'T-W864-IX-208', 20:28:31 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 20:28:31 INFO - 'USERNAME': 'cltbld', 20:28:31 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 20:28:31 INFO - 'WINDIR': 'C:\\windows', 20:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:28:32 INFO - Ignoring indexes: http://pypi.python.org/simple/ 20:28:32 INFO - Downloading/unpacking pip>=1.5 20:28:36 INFO - Running setup.py egg_info for package pip 20:28:36 INFO - warning: no files found matching 'pip\cacert.pem' 20:28:36 INFO - warning: no files found matching '*.html' under directory 'docs' 20:28:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 20:28:36 INFO - no previously-included directories found matching 'docs\_build\_sources' 20:28:36 INFO - Installing collected packages: pip 20:28:36 INFO - Found existing installation: pip 0.8.2 20:28:36 INFO - Uninstalling pip: 20:28:36 INFO - Successfully uninstalled pip 20:28:36 INFO - Running setup.py install for pip 20:28:36 INFO - warning: no files found matching 'pip\cacert.pem' 20:28:36 INFO - warning: no files found matching '*.html' under directory 'docs' 20:28:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 20:28:36 INFO - no previously-included directories found matching 'docs\_build\_sources' 20:28:36 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 20:28:36 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 20:28:36 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 20:28:36 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 20:28:36 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 20:28:36 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 20:28:36 INFO - Successfully installed pip 20:28:36 INFO - Cleaning up... 20:28:36 INFO - Return code: 0 20:28:36 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 20:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:36 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02293E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DAE90>, '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 0x01C8A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 20:28:36 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 20:28:36 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 20:28:36 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:28:36 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 20:28:36 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:28:36 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:28:36 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:28:36 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 20:28:36 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:28:36 INFO - 'DCLOCATION': 'SCL3', 20:28:36 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:28:36 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:28:36 INFO - 'HOMEDRIVE': 'C:', 20:28:36 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 20:28:36 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:28:36 INFO - 'KTS_VERSION': '1.19c', 20:28:36 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 20:28:36 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 20:28:36 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:28:36 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:36 INFO - 'MOZ_NO_REMOTE': '1', 20:28:36 INFO - 'NO_EM_RESTART': '1', 20:28:36 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:28:36 INFO - 'OS': 'Windows_NT', 20:28:36 INFO - 'OURDRIVE': 'C:', 20:28:36 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', 20:28:36 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:28:36 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:28:36 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:28:36 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:28:36 INFO - 'PROCESSOR_LEVEL': '6', 20:28:36 INFO - 'PROCESSOR_REVISION': '1e05', 20:28:36 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:28:36 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:28:36 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:28:36 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:28:36 INFO - 'PROMPT': '$P$G', 20:28:36 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:28:36 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:28:36 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:28:36 INFO - 'PWD': 'C:\\slave\\test', 20:28:36 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:28:36 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:28:36 INFO - 'SYSTEMDRIVE': 'C:', 20:28:36 INFO - 'SYSTEMROOT': 'C:\\windows', 20:28:36 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:36 INFO - 'TEST1': 'testie', 20:28:36 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:36 INFO - 'USERDOMAIN': 'T-W864-IX-208', 20:28:36 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 20:28:36 INFO - 'USERNAME': 'cltbld', 20:28:36 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 20:28:36 INFO - 'WINDIR': 'C:\\windows', 20:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:37 INFO - Downloading/unpacking psutil>=3.1.1 20:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:38 INFO - Installing collected packages: psutil 20:28:38 INFO - Successfully installed psutil 20:28:38 INFO - Cleaning up... 20:28:39 INFO - Return code: 0 20:28:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 20:28:39 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')]} 20:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:39 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')]} 20:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:39 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02293E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DAE90>, '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 0x01C8A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 20:28:39 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 20:28:39 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 20:28:39 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:28:39 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 20:28:39 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:28:39 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:28:39 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:28:39 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 20:28:39 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:28:39 INFO - 'DCLOCATION': 'SCL3', 20:28:39 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:28:39 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:28:39 INFO - 'HOMEDRIVE': 'C:', 20:28:39 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 20:28:39 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:28:39 INFO - 'KTS_VERSION': '1.19c', 20:28:39 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 20:28:39 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 20:28:39 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:28:39 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:39 INFO - 'MOZ_NO_REMOTE': '1', 20:28:39 INFO - 'NO_EM_RESTART': '1', 20:28:39 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:28:39 INFO - 'OS': 'Windows_NT', 20:28:39 INFO - 'OURDRIVE': 'C:', 20:28:39 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', 20:28:39 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:28:39 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:28:39 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:28:39 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:28:39 INFO - 'PROCESSOR_LEVEL': '6', 20:28:39 INFO - 'PROCESSOR_REVISION': '1e05', 20:28:39 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:28:39 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:28:39 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:28:39 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:28:39 INFO - 'PROMPT': '$P$G', 20:28:39 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:28:39 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:28:39 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:28:39 INFO - 'PWD': 'C:\\slave\\test', 20:28:39 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:28:39 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:28:39 INFO - 'SYSTEMDRIVE': 'C:', 20:28:39 INFO - 'SYSTEMROOT': 'C:\\windows', 20:28:39 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:39 INFO - 'TEST1': 'testie', 20:28:39 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:39 INFO - 'USERDOMAIN': 'T-W864-IX-208', 20:28:39 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 20:28:39 INFO - 'USERNAME': 'cltbld', 20:28:39 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 20:28:39 INFO - 'WINDIR': 'C:\\windows', 20:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:28:39 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 20:28:39 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 20:28:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:28:40 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 20:28:40 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) 20:28:40 INFO - Installing collected packages: mozsystemmonitor 20:28:40 INFO - Running setup.py install for mozsystemmonitor 20:28:40 INFO - Successfully installed mozsystemmonitor 20:28:40 INFO - Cleaning up... 20:28:41 INFO - Return code: 0 20:28:41 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 20:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:41 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02293E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DAE90>, '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 0x01C8A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 20:28:41 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 20:28:41 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 20:28:41 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:28:41 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 20:28:41 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:28:41 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:28:41 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:28:41 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 20:28:41 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:28:41 INFO - 'DCLOCATION': 'SCL3', 20:28:41 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:28:41 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:28:41 INFO - 'HOMEDRIVE': 'C:', 20:28:41 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 20:28:41 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:28:41 INFO - 'KTS_VERSION': '1.19c', 20:28:41 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 20:28:41 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 20:28:41 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:28:41 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:41 INFO - 'MOZ_NO_REMOTE': '1', 20:28:41 INFO - 'NO_EM_RESTART': '1', 20:28:41 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:28:41 INFO - 'OS': 'Windows_NT', 20:28:41 INFO - 'OURDRIVE': 'C:', 20:28:41 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', 20:28:41 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:28:41 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:28:41 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:28:41 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:28:41 INFO - 'PROCESSOR_LEVEL': '6', 20:28:41 INFO - 'PROCESSOR_REVISION': '1e05', 20:28:41 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:28:41 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:28:41 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:28:41 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:28:41 INFO - 'PROMPT': '$P$G', 20:28:41 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:28:41 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:28:41 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:28:41 INFO - 'PWD': 'C:\\slave\\test', 20:28:41 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:28:41 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:28:41 INFO - 'SYSTEMDRIVE': 'C:', 20:28:41 INFO - 'SYSTEMROOT': 'C:\\windows', 20:28:41 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:41 INFO - 'TEST1': 'testie', 20:28:41 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:41 INFO - 'USERDOMAIN': 'T-W864-IX-208', 20:28:41 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 20:28:41 INFO - 'USERNAME': 'cltbld', 20:28:41 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 20:28:41 INFO - 'WINDIR': 'C:\\windows', 20:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:41 INFO - Downloading/unpacking jsonschema==2.5.1 20:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:28:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:28:42 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 20:28:42 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 20:28:42 INFO - Downloading functools32-3.2.3-2.tar.gz 20:28:42 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 20:28:42 INFO - warning: no files found matching '*.txt' 20:28:42 INFO - no previously-included directories found matching 'build' 20:28:42 INFO - no previously-included directories found matching 'dist' 20:28:42 INFO - no previously-included directories found matching '.git*' 20:28:42 INFO - Installing collected packages: jsonschema, functools32 20:28:42 INFO - Running setup.py install for functools32 20:28:42 INFO - warning: no files found matching '*.txt' 20:28:42 INFO - no previously-included directories found matching 'build' 20:28:42 INFO - no previously-included directories found matching 'dist' 20:28:42 INFO - no previously-included directories found matching '.git*' 20:28:42 INFO - Successfully installed jsonschema functools32 20:28:42 INFO - Cleaning up... 20:28:43 INFO - Return code: 0 20:28:43 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 20:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:43 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02293E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DAE90>, '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 0x01C8A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 20:28:43 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 20:28:43 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:28:43 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:28:43 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 20:28:43 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:28:43 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:28:43 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:28:43 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 20:28:43 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:28:43 INFO - 'DCLOCATION': 'SCL3', 20:28:43 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:28:43 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:28:43 INFO - 'HOMEDRIVE': 'C:', 20:28:43 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 20:28:43 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:28:43 INFO - 'KTS_VERSION': '1.19c', 20:28:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 20:28:43 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 20:28:43 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:28:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:43 INFO - 'MOZ_NO_REMOTE': '1', 20:28:43 INFO - 'NO_EM_RESTART': '1', 20:28:43 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:28:43 INFO - 'OS': 'Windows_NT', 20:28:43 INFO - 'OURDRIVE': 'C:', 20:28:43 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 20:28:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:28:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:28:43 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:28:43 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:28:43 INFO - 'PROCESSOR_LEVEL': '6', 20:28:43 INFO - 'PROCESSOR_REVISION': '1e05', 20:28:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:28:43 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:28:43 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:28:43 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:28:43 INFO - 'PROMPT': '$P$G', 20:28:43 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:28:43 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:28:43 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:28:43 INFO - 'PWD': 'C:\\slave\\test', 20:28:43 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:28:43 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:28:43 INFO - 'SYSTEMDRIVE': 'C:', 20:28:43 INFO - 'SYSTEMROOT': 'C:\\windows', 20:28:43 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:43 INFO - 'TEST1': 'testie', 20:28:43 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:43 INFO - 'USERDOMAIN': 'T-W864-IX-208', 20:28:43 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 20:28:43 INFO - 'USERNAME': 'cltbld', 20:28:43 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 20:28:43 INFO - 'WINDIR': 'C:\\windows', 20:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 20:28:43 INFO - Cleaning up... 20:28:43 INFO - Return code: 0 20:28:43 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 20:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:43 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02293E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DAE90>, '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 0x01C8A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 20:28:43 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build 20:28:43 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:28:43 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:28:43 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 20:28:43 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:28:43 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:28:43 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:28:43 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 20:28:43 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:28:43 INFO - 'DCLOCATION': 'SCL3', 20:28:43 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:28:43 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:28:43 INFO - 'HOMEDRIVE': 'C:', 20:28:43 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 20:28:43 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:28:43 INFO - 'KTS_VERSION': '1.19c', 20:28:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 20:28:43 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 20:28:43 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:28:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:43 INFO - 'MOZ_NO_REMOTE': '1', 20:28:43 INFO - 'NO_EM_RESTART': '1', 20:28:43 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:28:43 INFO - 'OS': 'Windows_NT', 20:28:43 INFO - 'OURDRIVE': 'C:', 20:28:43 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 20:28:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:28:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:28:43 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:28:43 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:28:43 INFO - 'PROCESSOR_LEVEL': '6', 20:28:43 INFO - 'PROCESSOR_REVISION': '1e05', 20:28:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:28:43 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:28:43 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:28:43 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:28:43 INFO - 'PROMPT': '$P$G', 20:28:43 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:28:43 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:28:43 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:28:43 INFO - 'PWD': 'C:\\slave\\test', 20:28:43 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:28:43 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:28:43 INFO - 'SYSTEMDRIVE': 'C:', 20:28:43 INFO - 'SYSTEMROOT': 'C:\\windows', 20:28:43 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:43 INFO - 'TEST1': 'testie', 20:28:43 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:43 INFO - 'USERDOMAIN': 'T-W864-IX-208', 20:28:43 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 20:28:43 INFO - 'USERNAME': 'cltbld', 20:28:43 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 20:28:43 INFO - 'WINDIR': 'C:\\windows', 20:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:44 INFO - Downloading/unpacking blobuploader==1.2.4 20:28:44 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 20:28:44 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 20:28:45 INFO - Downloading blobuploader-1.2.4.tar.gz 20:28:45 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 20:28:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:45 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 20:28:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:45 INFO - Downloading docopt-0.6.1.tar.gz 20:28:45 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 20:28:45 INFO - Installing collected packages: blobuploader, requests, docopt 20:28:45 INFO - Running setup.py install for blobuploader 20:28:46 INFO - Running setup.py install for requests 20:28:46 INFO - Running setup.py install for docopt 20:28:46 INFO - Successfully installed blobuploader requests docopt 20:28:46 INFO - Cleaning up... 20:28:47 INFO - Return code: 0 20:28:47 INFO - Installing None into virtualenv C:\slave\test\build/venv 20:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:47 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02293E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DAE90>, '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 0x01C8A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277D520>, '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-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 20:28:47 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 20:28:47 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 20:28:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:28:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 20:28:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:28:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:28:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:28:47 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 20:28:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:28:47 INFO - 'DCLOCATION': 'SCL3', 20:28:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:28:47 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:28:47 INFO - 'HOMEDRIVE': 'C:', 20:28:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 20:28:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:28:47 INFO - 'KTS_VERSION': '1.19c', 20:28:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 20:28:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 20:28:47 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:28:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:47 INFO - 'MOZ_NO_REMOTE': '1', 20:28:47 INFO - 'NO_EM_RESTART': '1', 20:28:47 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:28:47 INFO - 'OS': 'Windows_NT', 20:28:47 INFO - 'OURDRIVE': 'C:', 20:28:47 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 20:28:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:28:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:28:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:28:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:28:47 INFO - 'PROCESSOR_LEVEL': '6', 20:28:47 INFO - 'PROCESSOR_REVISION': '1e05', 20:28:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:28:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:28:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:28:47 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:28:47 INFO - 'PROMPT': '$P$G', 20:28:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:28:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:28:47 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:28:47 INFO - 'PWD': 'C:\\slave\\test', 20:28:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:28:47 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:28:47 INFO - 'SYSTEMDRIVE': 'C:', 20:28:47 INFO - 'SYSTEMROOT': 'C:\\windows', 20:28:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:47 INFO - 'TEST1': 'testie', 20:28:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:47 INFO - 'USERDOMAIN': 'T-W864-IX-208', 20:28:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 20:28:47 INFO - 'USERNAME': 'cltbld', 20:28:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 20:28:47 INFO - 'WINDIR': 'C:\\windows', 20:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 20:28:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ysoo9d-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 20:28:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 20:28:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wdozb6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 20:28:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 20:28:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fkx14t-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 20:28:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 20:28:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ihy0uj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 20:28:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 20:28:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-c4ykfs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 20:28:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 20:28:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cejyhw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 20:28:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 20:28:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dmxxra-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 20:28:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 20:28:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jm5v5y-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 20:28:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 20:28:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xrcccs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 20:28:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 20:28:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ayvgyf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 20:28:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 20:28:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sviqgw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 20:28:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 20:28:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zqydng-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 20:28:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 20:28:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-efj8db-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 20:28:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 20:28:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rzdb_g-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 20:28:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 20:28:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-issrp1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 20:28:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 20:28:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hxfba1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 20:28:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 20:28:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-er6cy7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 20:28:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:28:50 INFO - Running setup.py install for manifestparser 20:28:50 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 20:28:50 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 20:28:50 INFO - Running setup.py install for mozcrash 20:28:51 INFO - Running setup.py install for mozdebug 20:28:51 INFO - Running setup.py install for mozdevice 20:28:51 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 20:28:51 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 20:28:51 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 20:28:51 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 20:28:52 INFO - Running setup.py install for mozfile 20:28:52 INFO - Running setup.py install for mozhttpd 20:28:52 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 20:28:52 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 20:28:53 INFO - Running setup.py install for mozinfo 20:28:53 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 20:28:53 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 20:28:53 INFO - Running setup.py install for mozInstall 20:28:53 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 20:28:53 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 20:28:53 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 20:28:53 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 20:28:53 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 20:28:53 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 20:28:53 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 20:28:53 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 20:28:53 INFO - Running setup.py install for mozleak 20:28:54 INFO - Running setup.py install for mozlog 20:28:54 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 20:28:54 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 20:28:55 INFO - Running setup.py install for moznetwork 20:28:55 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 20:28:55 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 20:28:55 INFO - Running setup.py install for mozprocess 20:28:56 INFO - Running setup.py install for mozprofile 20:28:56 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 20:28:56 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 20:28:56 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 20:28:56 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 20:28:56 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 20:28:56 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 20:28:56 INFO - Running setup.py install for mozrunner 20:28:56 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 20:28:56 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 20:28:57 INFO - Running setup.py install for mozscreenshot 20:28:57 INFO - Running setup.py install for moztest 20:28:58 INFO - Running setup.py install for mozversion 20:28:58 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 20:28:58 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 20:28:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:28:58 INFO - Cleaning up... 20:28:58 INFO - Return code: 0 20:28:58 INFO - Installing None into virtualenv C:\slave\test\build/venv 20:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:58 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02293E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DAE90>, '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 0x01C8A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277D520>, '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-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 20:28:58 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 20:28:58 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 20:28:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:28:58 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 20:28:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:28:58 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:28:58 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:28:58 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 20:28:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:28:58 INFO - 'DCLOCATION': 'SCL3', 20:28:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:28:58 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:28:58 INFO - 'HOMEDRIVE': 'C:', 20:28:58 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 20:28:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:28:58 INFO - 'KTS_VERSION': '1.19c', 20:28:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 20:28:58 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 20:28:58 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:28:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:58 INFO - 'MOZ_NO_REMOTE': '1', 20:28:58 INFO - 'NO_EM_RESTART': '1', 20:28:58 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:28:58 INFO - 'OS': 'Windows_NT', 20:28:58 INFO - 'OURDRIVE': 'C:', 20:28:58 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 20:28:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:28:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:28:58 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:28:58 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:28:58 INFO - 'PROCESSOR_LEVEL': '6', 20:28:58 INFO - 'PROCESSOR_REVISION': '1e05', 20:28:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:28:58 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:28:58 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:28:58 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:28:58 INFO - 'PROMPT': '$P$G', 20:28:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:28:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:28:58 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:28:58 INFO - 'PWD': 'C:\\slave\\test', 20:28:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:28:58 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:28:58 INFO - 'SYSTEMDRIVE': 'C:', 20:28:58 INFO - 'SYSTEMROOT': 'C:\\windows', 20:28:58 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:58 INFO - 'TEST1': 'testie', 20:28:58 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:28:58 INFO - 'USERDOMAIN': 'T-W864-IX-208', 20:28:58 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 20:28:58 INFO - 'USERNAME': 'cltbld', 20:28:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 20:28:58 INFO - 'WINDIR': 'C:\\windows', 20:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 20:28:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hs3oyw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 20:28:59 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)) 20:28:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 20:28:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7vxabn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 20:28:59 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)) 20:28:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 20:28:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ghaeby-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 20:28:59 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)) 20:28:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 20:28:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jsr_07-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 20:28:59 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)) 20:28:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 20:28:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xefdds-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 20:28:59 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)) 20:28:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 20:28:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cuoj17-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 20:28:59 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)) 20:28:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 20:28:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kbtmeb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 20:28:59 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)) 20:28:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 20:28:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8fek1v-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 20:28:59 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)) 20:28:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 20:28:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bewvny-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 20:28:59 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)) 20:28:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 20:28:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ubb4sx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 20:29:00 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)) 20:29:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 20:29:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-swpkg0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 20:29:00 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)) 20:29:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 20:29:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3szijl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 20:29:00 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)) 20:29:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 20:29:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3tzzxk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 20:29:00 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)) 20:29:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 20:29:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-q1hhpi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 20:29:00 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)) 20:29:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 20:29:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eckmw5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 20:29:00 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)) 20:29:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 20:29:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7zd9kd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 20:29:00 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)) 20:29:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 20:29:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cropdm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 20:29:00 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)) 20:29:00 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)) 20:29:00 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)) 20:29:00 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)) 20:29:00 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)) 20:29:00 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)) 20:29:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 20:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:01 INFO - Downloading blessings-1.6.tar.gz 20:29:01 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 20:29:02 INFO - Installing collected packages: blessings 20:29:02 INFO - Running setup.py install for blessings 20:29:02 INFO - Successfully installed blessings 20:29:02 INFO - Cleaning up... 20:29:05 INFO - Return code: 0 20:29:05 INFO - Done creating virtualenv C:\slave\test\build/venv. 20:29:05 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 20:29:05 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 20:29:05 INFO - Reading from file tmpfile_stdout 20:29:05 INFO - Using _rmtree_windows ... 20:29:05 INFO - Using _rmtree_windows ... 20:29:05 INFO - Current package versions: 20:29:05 INFO - blessings == 1.6 20:29:05 INFO - blobuploader == 1.2.4 20:29:05 INFO - docopt == 0.6.1 20:29:05 INFO - functools32 == 3.2.3-2 20:29:05 INFO - jsonschema == 2.5.1 20:29:05 INFO - manifestparser == 1.1 20:29:05 INFO - mozInstall == 1.12 20:29:05 INFO - mozcrash == 0.17 20:29:05 INFO - mozdebug == 0.1 20:29:05 INFO - mozdevice == 0.48 20:29:05 INFO - mozfile == 1.2 20:29:05 INFO - mozhttpd == 0.7 20:29:05 INFO - mozinfo == 0.9 20:29:05 INFO - mozleak == 0.1 20:29:05 INFO - mozlog == 3.4 20:29:05 INFO - moznetwork == 0.27 20:29:05 INFO - mozprocess == 0.23 20:29:05 INFO - mozprofile == 0.28 20:29:05 INFO - mozrunner == 6.12 20:29:05 INFO - mozscreenshot == 0.1 20:29:05 INFO - mozsystemmonitor == 0.3 20:29:05 INFO - moztest == 0.7 20:29:05 INFO - mozversion == 1.4 20:29:05 INFO - psutil == 3.1.1 20:29:05 INFO - requests == 1.2.3 20:29:05 INFO - Installing None into virtualenv C:\slave\test\build/venv 20:29:05 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')]} 20:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:05 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')]} 20:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:05 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02293E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DAE90>, '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 0x01C8A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277D520>, '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-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 20:29:05 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 20:29:05 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 20:29:05 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:29:05 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 20:29:05 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:29:05 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:29:05 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:29:05 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 20:29:05 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:29:05 INFO - 'DCLOCATION': 'SCL3', 20:29:05 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:29:05 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:29:05 INFO - 'HOMEDRIVE': 'C:', 20:29:05 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 20:29:05 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:29:05 INFO - 'KTS_VERSION': '1.19c', 20:29:05 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 20:29:05 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 20:29:05 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:29:05 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:05 INFO - 'MOZ_NO_REMOTE': '1', 20:29:05 INFO - 'NO_EM_RESTART': '1', 20:29:05 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:29:05 INFO - 'OS': 'Windows_NT', 20:29:05 INFO - 'OURDRIVE': 'C:', 20:29:05 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', 20:29:05 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:29:05 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:29:05 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:29:05 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:29:05 INFO - 'PROCESSOR_LEVEL': '6', 20:29:05 INFO - 'PROCESSOR_REVISION': '1e05', 20:29:05 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:29:05 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:29:05 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:29:05 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:29:05 INFO - 'PROMPT': '$P$G', 20:29:05 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:29:05 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:29:05 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:29:05 INFO - 'PWD': 'C:\\slave\\test', 20:29:05 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:29:05 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:29:05 INFO - 'SYSTEMDRIVE': 'C:', 20:29:05 INFO - 'SYSTEMROOT': 'C:\\windows', 20:29:05 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:29:05 INFO - 'TEST1': 'testie', 20:29:05 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:29:05 INFO - 'USERDOMAIN': 'T-W864-IX-208', 20:29:05 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 20:29:05 INFO - 'USERNAME': 'cltbld', 20:29:05 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 20:29:05 INFO - 'WINDIR': 'C:\\windows', 20:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:06 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)) 20:29:06 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)) 20:29:06 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)) 20:29:06 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)) 20:29:06 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)) 20:29:06 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)) 20:29:06 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)) 20:29:06 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)) 20:29:06 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)) 20:29:06 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)) 20:29:06 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)) 20:29:06 INFO - Cleaning up... 20:29:06 INFO - Return code: 0 20:29:06 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 20:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:06 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x021EC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02293E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DAE90>, '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 0x01C8A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 20:29:06 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 20:29:06 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:29:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:29:06 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 20:29:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:29:06 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:29:06 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:29:06 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 20:29:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:29:06 INFO - 'DCLOCATION': 'SCL3', 20:29:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:29:06 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:29:06 INFO - 'HOMEDRIVE': 'C:', 20:29:06 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 20:29:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:29:06 INFO - 'KTS_VERSION': '1.19c', 20:29:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 20:29:06 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 20:29:06 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:29:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:06 INFO - 'MOZ_NO_REMOTE': '1', 20:29:06 INFO - 'NO_EM_RESTART': '1', 20:29:06 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:29:06 INFO - 'OS': 'Windows_NT', 20:29:06 INFO - 'OURDRIVE': 'C:', 20:29:06 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 20:29:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:29:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:29:06 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:29:06 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:29:06 INFO - 'PROCESSOR_LEVEL': '6', 20:29:06 INFO - 'PROCESSOR_REVISION': '1e05', 20:29:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:29:06 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:29:06 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:29:06 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:29:06 INFO - 'PROMPT': '$P$G', 20:29:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:29:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:29:06 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:29:06 INFO - 'PWD': 'C:\\slave\\test', 20:29:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:29:06 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:29:06 INFO - 'SYSTEMDRIVE': 'C:', 20:29:06 INFO - 'SYSTEMROOT': 'C:\\windows', 20:29:06 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:29:06 INFO - 'TEST1': 'testie', 20:29:06 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:29:06 INFO - 'USERDOMAIN': 'T-W864-IX-208', 20:29:06 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 20:29:06 INFO - 'USERNAME': 'cltbld', 20:29:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 20:29:06 INFO - 'WINDIR': 'C:\\windows', 20:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 20:29:06 INFO - Cleaning up... 20:29:06 INFO - Return code: 0 20:29:06 INFO - Running post-action listener: _resource_record_post_action 20:29:06 INFO - Running post-action listener: _start_resource_monitoring 20:29:06 INFO - Starting resource monitoring. 20:29:06 INFO - [mozharness: 2016-10-27 03:29:06.507000Z] Finished create-virtualenv step (success) 20:29:06 INFO - [mozharness: 2016-10-27 03:29:06.507000Z] Running install step. 20:29:06 INFO - Running pre-action listener: _resource_record_pre_action 20:29:06 INFO - Running main action method: install 20:29:06 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 20:29:06 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 20:29:06 INFO - Reading from file tmpfile_stdout 20:29:06 INFO - Using _rmtree_windows ... 20:29:06 INFO - Using _rmtree_windows ... 20:29:06 INFO - Detecting whether we're running mozinstall >=1.0... 20:29:06 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 20:29:06 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 20:29:06 INFO - Reading from file tmpfile_stdout 20:29:06 INFO - Output received: 20:29:06 INFO - Usage: mozinstall-script.py [options] installer 20:29:06 INFO - Options: 20:29:06 INFO - -h, --help show this help message and exit 20:29:06 INFO - -d DEST, --destination=DEST 20:29:06 INFO - Directory to install application into. [default: 20:29:06 INFO - "C:\slave\test"] 20:29:06 INFO - --app=APP Application being installed. [default: firefox] 20:29:06 INFO - Using _rmtree_windows ... 20:29:06 INFO - Using _rmtree_windows ... 20:29:06 INFO - mkdir: C:\slave\test\build\application 20:29:06 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'] 20:29:06 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 20:29:09 INFO - Reading from file tmpfile_stdout 20:29:09 INFO - Output received: 20:29:09 INFO - C:\slave\test\build\application\firefox\firefox.exe 20:29:09 INFO - Using _rmtree_windows ... 20:29:09 INFO - Using _rmtree_windows ... 20:29:09 INFO - Running post-action listener: _resource_record_post_action 20:29:09 INFO - [mozharness: 2016-10-27 03:29:09.334000Z] Finished install step (success) 20:29:09 INFO - [mozharness: 2016-10-27 03:29:09.334000Z] Running run-tests step. 20:29:09 INFO - Running pre-action listener: _resource_record_pre_action 20:29:09 INFO - Running main action method: run_tests 20:29:09 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 20:29:09 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 20:29:09 INFO - Python 2.7.3 20:29:09 INFO - Return code: 0 20:29:09 INFO - grabbing minidump binary from tooltool 20:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:29:09 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 0x022DAE90>, '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 0x01C8A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0277D520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 20:29:09 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 20:29:09 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 20:29:09 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 20:29:09 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 20:29:11 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpx1mrbv 20:29:11 INFO - INFO - File integrity verified, renaming tmpx1mrbv to win32-minidump_stackwalk.exe 20:29:11 INFO - Return code: 0 20:29:11 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 20:29:11 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 20:29:11 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 20:29:11 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 20:29:11 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 20:29:11 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-208', '--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 20:29:11 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Autoland --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-208 --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 20:29:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:29:11 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 20:29:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:29:11 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:29:11 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:29:11 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 20:29:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:29:11 INFO - 'DCLOCATION': 'SCL3', 20:29:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:29:11 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:29:11 INFO - 'HOMEDRIVE': 'C:', 20:29:11 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 20:29:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:29:11 INFO - 'KTS_VERSION': '1.19c', 20:29:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 20:29:11 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 20:29:11 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 20:29:11 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 20:29:11 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:29:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:11 INFO - 'MOZ_NO_REMOTE': '1', 20:29:11 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 20:29:11 INFO - 'NO_EM_RESTART': '1', 20:29:11 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:29:11 INFO - 'OS': 'Windows_NT', 20:29:11 INFO - 'OURDRIVE': 'C:', 20:29:11 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', 20:29:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:29:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:29:11 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:29:11 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:29:11 INFO - 'PROCESSOR_LEVEL': '6', 20:29:11 INFO - 'PROCESSOR_REVISION': '1e05', 20:29:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:29:11 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:29:11 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:29:11 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:29:11 INFO - 'PROMPT': '$P$G', 20:29:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:29:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:29:11 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:29:11 INFO - 'PWD': 'C:\\slave\\test', 20:29:11 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 20:29:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:29:11 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:29:11 INFO - 'SYSTEMDRIVE': 'C:', 20:29:11 INFO - 'SYSTEMROOT': 'C:\\windows', 20:29:11 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:29:11 INFO - 'TEST1': 'testie', 20:29:11 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:29:11 INFO - 'USERDOMAIN': 'T-W864-IX-208', 20:29:11 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 20:29:11 INFO - 'USERNAME': 'cltbld', 20:29:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 20:29:11 INFO - 'WINDIR': 'C:\\windows', 20:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:29:11 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-208', '--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 20:29:12 INFO - mozversion application_buildid: 20161026174805 20:29:12 INFO - mozversion application_changeset: 532415dbd6208ff854e65760f5ea9241de4edd7b 20:29:12 INFO - mozversion application_display_name: Nightly 20:29:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:29:12 INFO - mozversion application_name: Firefox 20:29:12 INFO - mozversion application_remotingname: firefox 20:29:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:29:12 INFO - mozversion application_vendor: Mozilla 20:29:12 INFO - mozversion application_version: 52.0a1 20:29:12 INFO - mozversion platform_buildid: 20161026174805 20:29:12 INFO - mozversion platform_changeset: 532415dbd6208ff854e65760f5ea9241de4edd7b 20:29:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:29:12 INFO - mozversion platform_version: 52.0a1 20:29:12 INFO - using testdate: 1477538952 20:29:12 INFO - actual date: 1477538952 20:29:12 INFO - starting webserver on 'localhost:49276' 20:29:12 INFO - SUITE-START | Running 2 tests 20:29:12 INFO - TEST-START | dromaeo_css 20:29:12 INFO - operating with platform_type : w8_ 20:29:12 INFO - Initialising browser for dromaeo_css test... 20:29:12 INFO - TEST-INFO | started process 1392 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpt_dzpt\profile http://localhost:49276/getInfo.html) 20:29:20 INFO - PROCESS | 1392 | __metrics Screen width/height:1600/1200 20:29:20 INFO - PROCESS | 1392 | colorDepth:24 20:29:20 INFO - PROCESS | 1392 | Browser inner width/height: 1010/674 20:29:20 INFO - PROCESS | 1392 | __metrics 20:29:21 INFO - PROCESS | 1392 | 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" 20:29:21 INFO - PROCESS | 1392 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:29:22 INFO - TEST-INFO | 1392: exit 0 20:29:22 INFO - Browser initialized. 20:29:22 INFO - Running cycle 1/1 for dromaeo_css test... 20:29:22 INFO - TEST-INFO | started process 3424 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpt_dzpt\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:23 INFO - PROCESS | 3424 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 20:29:34 INFO - PROCESS | 3424 | RSS: Main: 159367168 20:29:34 INFO - PROCESS | 3424 | 20:30:25 INFO - PROCESS | 3424 | 1477539025101 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] 20:32:37 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 20:32:38 INFO - PROCESS | 3424 | RSS: Main: 276094976 20:32:38 INFO - PROCESS | 3424 | 20:35:41 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 20:35:42 INFO - PROCESS | 3424 | RSS: Main: 226263040 20:35:42 INFO - PROCESS | 3424 | 20:38:44 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 20:38:44 INFO - PROCESS | 3424 | RSS: Main: 169697280 20:38:44 INFO - PROCESS | 3424 | 20:41:47 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 20:41:47 INFO - PROCESS | 3424 | RSS: Main: 183070720 20:41:47 INFO - PROCESS | 3424 | 20:44:50 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 20:44:51 INFO - PROCESS | 3424 | RSS: Main: 163770368 20:44:51 INFO - PROCESS | 3424 | 20:47:54 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 20:47:54 INFO - PROCESS | 3424 | RSS: Main: 205209600 20:47:54 INFO - PROCESS | 3424 | 20:47:54 INFO - PROCESS | 3424 | __start_tp_report 20:47:54 INFO - PROCESS | 3424 | _x_x_mozilla_page_load 20:47:54 INFO - PROCESS | 3424 | _x_x_mozilla_page_load_details 20:47:54 INFO - PROCESS | 3424 | |i|pagename|runs| 20:47:54 INFO - PROCESS | 3424 | |0;dojo.html;2819.901303454379;2830.349019725462;2863.9999999999995;2868.3832975910186;2872.1527149490885;4933.62997775167;4992.176290912004;5011.373578302712;5042.369703787027;5062.949370506294;4970.254461830718;5001.974990125053;5017.322661440704;5019.2471129330615;5055.064813009587;4565.201089809287;4569.428821397325;4581.312803079548;4581.748003859786;4641.373414589038;4597.954020459786;4605.769711514427;4633.281841314585;4639.095376401586;4643.396358473394;4593.058423023273;4605.815767369301;4628.120657075145;4630.675852690313;4661.044485880387;4604.4014278143795;4642.558956899123;4669.229577119771;4680.859574212779;4746.976265118687;4511.075229577961;4614.446266448014;4615.46922103959;4655.11552804966;4657.767111644438;4944.777485013183;5027.145385284511;5054.797808087672;5093.159628661267;5096.872578185538;5480.287562616874;5489.094299440588;5496.615236933416;5510.0632892408385;5540.944590554123;5573.024720673907;5581.134924086773;5591.133374326986;5599.944000560024;5638.577106716972;4906;4976.079425306258;4978.551930326252;5036.924446133311;5094.949050509522;5541.085720856095;5593.720313984284;5627.465390787868;5628.212050312959;5664.716764161775;5290.836016076457;5358.115910874662;5365.3293338332705;5365.490278423544;5373.838784836461;5325.4674532547215;5378.2470454136455;5380.24676545284;5460.672359658433;5548.250986116904;5360.973195133999;5374.140137577969;5375.408705042442;5377.435369286247;5378.166384210375;5352.518273355417;5369.5972802040005;5370.946290537045;5377.623566350396;5379.462053794589;3524.0661224775454;3549.8757543485854;3552.1119720069983;3559.039059453985;3580.9820950895078;3208.470602350633;3221.3557288542384;3250.3661785951986;3269.75476839238;3286.375588638199;5223.399309079428;5228.37259528859;5233.842984710464;5244.344456942882;5285.973570132125;5247.475252474722;5249.2126181073145;5264.789408423697;5452.645578037414;5457.372402173722;5053.343065401475;5092.516210959953;5095.108356037678;5099.464556221617;5100.438951715309;4348.543402942645;4369.650427965818;4385.561443855589;4394.318880573516;4399.5820397062225;5452;5454.372747134131;5458.863528411822;5466.9179962300595;5466.945330546723;5325.786968521215;5327.440618734977;5328.227407025882;5534.889302214014;5553.305836770403;5715.799947001835;5724.055530837365;5726.198332233407;5746.655200687972;5784.392638772868;5462.726863656881;5472;5473.808416705396;5474.479924407175;5474.972625136849;5471.671699698031;5551.084071128219;5567.589487947941;5575.386707462095;5639.830805075854;5261.131913234427;5346.117890548016;5387.81142660005;5418.512333889968;5465.453454654503;5359.303290572357;5363.919541206807;5401.405845356929;5402.216678581505;5405.378381486179;5164.715940623302;5413.891722165614;5432.185172224198;5434.239206511171;5496.6701997880255;5271.4464981176425;5330.733463326741;5430.049741295336;5459.4540545946675;5466.644668096561;5393.9730301348245;5426.67439953604;5429.104197807475;5438.401775804579;5461.890762184655 20:47:54 INFO - PROCESS | 3424 | |1;ext.html;542.3979382884997;570.60913274407;572.6792995922284;580.1993249315943;590.6456126324206;27968.720312796864;36805.44791828125;38012.23975520488;38064;41278.587214127925;36994.44508332377;37855.432168517495;37969.24061518768;38146.61853381465;38151.61848381515;8115.553644549533;8183.754487365389;8257.25684688378;8264.710735124272;8275.172482751737;7338;7513.211112833156;9832.164266037395;10023.148032417217;10091.64679236227;10041.447720375376;10114.494275286243;10114.521942124153;10160.339577927449;10165.186785057178;7146.3925566326925;7294.635268236567;9876.160526355268;9886.555105020292;9915.950420247924;9509.857352139723;9867.259955503367;9871.457069861155;10001.34991225568;10011.598376227334;36080.27839443197;36168.457473137925;36336.45495317572;36400.63599363999;36481;3080.661127275998;3088.2742555499663;3088.33600775832;3135.1378370948173;3257.5276584895296;28508.00221992241;28602.284942876595;28892.277693057633;29288.121356359345;29583;3960.851353107624;3989.8204580793645;4002.799160251913;4018.095928416112;4090.468239128924;293478;293960;294188;296403;296428.99999999785;28321.858390707916;47748.28377574339;48028.27957580639;48071.75964120157;48088;27080.864595676896;28159.15522534327;28238.435231295258;28256.71743282582;28262.293442664097;12751.36243187837;12873;12897.226166430044;12903.806442903364;12923.22460652364;10133.240006999504;10408.635697750542;10887;10912.745034320997;10956.959088886542;6287.842803929847;6430.164078669836;6430.324815894357;6442.259140198843;6509.707063182168;2581.264339663187;2587.780038696694;2609.8042646801564;2612.3860892690204;2647.510210611043;825.8885050518103;875.2953872132994;880.2429910277157;911.9316051296179;919.4023884475012;26510.734892651213;27242.455150896873;27529.174124776287;27893.302667433476;28134.85932570324;882.2104216725994;924.4222361024359;946.2997381937316;979.603260679426;1028.573142146016;14145.884416801096;14222.2177780221;14246;14402;14456.710865782836;405890;409842;410022;410358;412523;47929.76035119802;48198.759006204746;48327.27509087366;48362;48363;1050.7163065972145;1086.5056399338441;1117.4412793603199;1147.5065721739566;1152.09560495011;25615.6157657639;27620.585691214244;27787.722122778512;28074.2981425466;28454.288642783267;40590.39114413227;40994.38508422316;41006.384904225866;41010.17979640331;41053;331475;331498;331541;331811;332051;23669.881650591637;24370.75629243756;25183.118590849233;25196.74803251944;26326.736732632427;40610.39084413677;41200;41223.381649275885;41258;41294.58705413028;34121.146971324924;34602.307953841286;34656.82671586626;35021.29957400889;35260.47109293311;34024.319513609094;34948.47577286394;34992.12519686927;35140.82429587836;35791.46312805258;33512.83243583766;33573.16067098244;33620.83189584036;33702.49446258259;34377.140571485914;30760.230994225323;31318.06045818629;31389.529157062207;31538.369232615678;31552.52671209888;23754.168604098773;23770.564959986077;24020.39949001289;24254.15110471125;24387 20:47:54 INFO - PROCESS | 3424 | |2;jquery.html;323.77174092264954;340.4535720169129;341.1437292396085;341.60885785775287;352.140776505327;13166.275854827993;14096.083754555946;16612.08633525157;17050.82949170508;17823.91088044558;16206.513804585882;16483.505494835143;16722.66554668906;16758.664826703458;16785.32858685651;4312.900210446347;5149.948500514994;5394.838154855361;5400.756965936543;5409.053415652264;5252.422233554306;5361.678299302035;5369.4362091980365;5376.865578360533;5395.838124856261;5090.796368145269;5283.63014588979;5315.441878602749;5316.6544174628525;5317.202419637066;5247.606429517801;5264.526192642642;5268.947310526923;5275.868103297429;5296.152615581508;4449.888752781174;4592.402987611623;4620.260758278693;4624.699394539344;4656.231721765905;19843.305484308123;19957.700634490495;20265.39203823873;20435.897820510952;20706.792932070788;2018.8889611071386;2046.6725323948097;2054.897255137237;2457.569925263072;2718.4156997707355;12410.81383779244;12441.626751197478;12503.999680025576;12542.310172940484;13399.19604823704;1734.5230061732998;1749.8162692917188;1784;1785.1431312969846;1808.9366872159542;57355.426445735844;59322.110168347506;63517.97532905389;70742.29257707408;73375.63312183459;8731.781705457415;9159.129882661136;9333.906660933304;9381.155695987394;9494;12680.80978785319;12689;12690.365481725878;12705.618831435071;12711;6944.895826562605;7154.141503019671;7184.137903451515;7240.674169662378;7275.454340924346;7006.194287656883;7034.437245020386;7102.538335008208;7145.464090193256;7151.106111736033;5755.395683453261;5830.434608772127;5848.64908105515;5862.824115276549;5948.524118070544;1602.8156761972523;1670.807857096425;1678.1860797513195;1681.1510187355307;1684.2252563820534;812.7033632724014;857.2841677199483;860.5396113079472;904.1681652879366;914.2457472585011;16953.745693814602;17159.828401716073;17362.218700158523;17488.300467981393;17641.911790440965;859.6303589456469;866.0733015673295;877.6533269358695;895.7268033249791;920.4707293306242;9481.668141615148;9662.806743865223;9751.073648003428;9849.950750246346;9869;384032;396812;397890;398946;399628;73764.2623573768;80185.59907200426;90994;91656;93594;858.356232825381;880.480516495258;883.6421249394006;883.960221790021;896.1397058823472;14964.700705986037;15175.392984280505;15229.162396068323;15486.225688715744;15711.135887526296;35758.64241357553;36334.27331453409;36777.26445471022;36803.63196368002;37234.25531489409;48256.7587162062;50911.236331455795;51933.171360867986;52127.21809172941;54021.45978540164;7220.277972202738;7375.889361659472;7584.810379740551;7655.387568994578;7658.081030276179;10461.581536738446;11279.830802537805;11838.585649502225;11857;11946.283223006647;10084;10087.546060427445;10325.896741032793;10334.173266138841;10497.842532362174;9964.402135871871;10035.598576056876;10184.18526517862;10322.587096516056;10328;10034.849477257992;10085;10361.4301213434;10434.582616695247;10522.579096836042;7448.925510744823;7463.850722985619;7480.588567628833;7495.625218738932;7762.3790096793255;7865.016872890888;9834;10080.395176289447;10093.630725190676;10614.787704245717 20:47:54 INFO - PROCESS | 3424 | |3;mootools.html;1115.6876074699078;1140.2360418519593;1144.1819099343973;1234.6049264235444;1395.699924516228;6477.125588045613;7165.4984151109375;7445.143808462015;7447.2552744725635;7470.7758767237;7410.740624078158;7450.701971921117;7456.96271518643;7464.701411943516;7481.625918704057;1960.0591715976304;1985.1761518969683;1985.4043786863956;1987.1951859496926;1987.741593592831;1960.1669290551529;1984.3054930774258;1989.9900500497477;1998.3105828489147;2002.5394159343286;1945.7762357328877;1960.4608732598579;1969.2319995201883;1975.2790231565448;1975.861689681723;1880.9059547022662;1893.0440127735405;1894.7536820213354;1896.4500294914458;1898.69620860663;1875.8405535529496;1883.1431698577114;1888.33908132154;1914.626647803679;1919.184346652667;7026.824329391755;7061.823454413629;7252.528585641917;7395.963020184919;7435.776926692208;4397.494288156871;4530.3431002504785;4555.612772914306;4568.269076947672;4573.748443835588;2856.243095579673;2996.2060054085687;3051.786374953754;3054.8167109973474;3059.7705172112182;922.1976880114277;947.8862536495595;949.520492151459;955.2835373469898;958.4105774948426;10075.345102568383;10187.54156062979;10191.490425478696;10255;10269.332493387981;3680.9263814723554;3756.8685096022054;3775.339315619756;3778.471014058034;3800.7149463789774;7886.802829929183;7906.486078404885;7908.52548847071;7909.841803163905;7919.089304729914;4429.357743127229;4437.112577484516;4438.733675979452;4441.666874984389;4454.465464144323;3499.7900125992523;3730.1047748540154;3749.2126653402547;4191.601797829201;4197.412362269285;3105.409972105338;3139.356431931494;3187.4103290891258;3188.2666986593213;3188.2985743136474;896.1352295035322;904.8733177355175;906.8231694819578;912.6942474271193;915.7802127489488;734.4601717737459;749.7076140305285;760.7983884270673;780.360104714129;782.984340313202;4568.177728008924;4677.46209185948;4744.454387745384;4798.304245884327;4873.439554451213;732.5275197497691;770.2451597434433;800.1838125112469;805.5569436809732;811.2536466450879;3143.748500119985;3158.3209609933974;3164.715175634204;3233.8868139615;3324.0360295514515;8854.77863053416;9021.954890225637;9103.499307538017;9117.863232051524;9159.633614655339;9021.639134434548;9046.411983221069;9046.638134474548;9085.909140908638;9106.408083474686;6613.437857782046;6731.730730770812;6738.32616738332;6759.053732477457;6789.117414736152;4528.773561321987;4569.2232320506255;4596.770161491979;4701.482836887872;4717.056588682209;8066.677332906618;8097.2307630774985;8141.69732842766;8196.590170491332;8204.261616454547;7638.083429988437;7942.483738556975;8190.385721071063;8366.372522060992;8403.705870294754;5879.088741245114;6058.515318774399;6078.057901025348;6121.571489995657;6142.293636231711;7326.633668316456;7350.117985841734;7383.483156179016;7428.814279643052;7431.182569917197;6615.17310336208;6623.503237257321;6661.500387471056;6689.464842812466;6693.497987650849;6426.100345951477;6456.806295811133;6538;6554.180727409074;6587.934120658923;6025.8192254232445;6065.60573562717;6121.693915304306;6124.663143527148;6129.417705317987;3940.1922605866303;3961.4255932890146;4009.2382447334912;4012.678985681197;4041.8181181847476;3889.8444062237195;3913.2173565287626;3955.5253369595835;3991.7405368650943;4060.675145988373 20:47:54 INFO - PROCESS | 3424 | |4;prototype.html;277.26109917071005;283.1491368437844;287.78416187859114;288.28505306839025;290.9010936281664;5112.974435127824;5119.974400127999;5159.787449949268;5162.8193013244545;5185.299984502091;4839.540243676854;4924.704517728939;5005.299258103868;5045.798168073273;5080.390353157626;3912.2371137628174;3922.941155882664;3930.960690393088;3935.60643935607;3942.7634341939433;3907.0623050467825;3933.7443066200603;3948.151147503286;3950.3679411294056;3953.802309884494;3710.424884142962;3747.9063023424496;3883.359245724452;3904.960950390488;3926.862559810407;3884.3590807516725;3888.6111388861173;3891.8832435026993;3895.182011777544;3899.2591407632744;3433.3476639438677;3439.1230236289834;3446.758726889119;3446.758726889119;3452.585689717225;4842.225243960985;4917.328108443146;5010;5023.748812559357;5042.243663450475;4535.841245556389;4537.773111344452;4539.296409056601;4541.84103556374;4551;5289.788408463657;5364.463553644643;5366.624336296461;5377;5389.380221274564;3452.2750222453064;3650.5071815305123;3801.657850793414;3805.9429108563395;3806.7335286529956;5587.189857470685;5587.413321601254;5598.328200615912;5600.4959553639965;5602.467765562265;3762.3792074307435;3767.56672982605;3774.9622503774613;3778.4899038629433;3780.1305699689224;3820.675242604354;3825.101101241206;3825.7513261637905;3840.2895464339185;3840.347140986039;4232.894177645583;4414.602685758297;4462.397576327155;4472.635846066981;4475.283954567253;5369.570434365241;5373.731313434313;5395.325584301962;5399.784008639689;5429;1265.335698758141;1313.481174935895;1329.1759109352263;1336.766065938457;1337.4048548396065;838.2623291503438;863.6329559937002;882.4308321132834;885.880406145175;894.3560636341823;5307.814226502054;5314.634987430633;5316.627836051439;5322.520973112439;5336.973315133399;5538.280023596906;5541.536539662711;5558.277423934944;5565.833025009256;5569.610127291051;5090.312807770903;5275.947240527546;5306.832496850687;5307.7080760557765;5319.893602127936;2937.280366310225;2942.735153836165;2948.8083274587084;2951.439226546949;2964.2293003819163;5422.240886275925;5602.971985140048;5657.519110875622;5666.829995100071;5668.9716551417805;5576.498115169573;5582.27430434041;5584.636998595079;5592.384837667934;5599.832005039855;5644.238027866268;5645.830625081254;5661.207430959669;5672.03575392176;5674.886502270014;5263.6052296078715;5452.563794896319;5474.616776825584;5497;5523.54202379937;5367.919481207707;5391.595630327663;5392.676439413648;5397.757100930389;5409.350877894678;5407.675539467645;5647.463490968352;5650.152477128299;5651.406602306699;5661.631993920547;3700.40793473043;3730.7201959852578;3730.8321125548873;3741.7380783344906;3750.34368985421;5295.4969277918535;5511.862203444946;5529.889402212014;5533.5849811265125;5536.335639723259;5224.373075230845;5336.17289320156;5378.139497680352;5386.245925570345;5387.49150237934;5298.648844544617;5326.600504962221;5357.624966252325;5360.597955153301;5368.543673787615;5060.924086138784;5168.741562921764;5232.3459567554055;5264.947350526446;5276.445973172762;5422.620416570802;5435.374931882884;5445.673259604437;5449.591280654046;5458.290422245242;5360.3299587551555;5365.517103460707;5367.543758780547;5381.2197231402015;5387.191921211849 20:47:54 INFO - PROCESS | 3424 | |5;yui.html;616.2081724983396;709.5636183746994;718.493462109213;721.5093736259341;732.8167958010497;13352.7329453411;13995.93002034991;14190.077644953084;14210.573682789507;14727.190004549746;13342;13750;13751;13756.386286605539;13838.792418113711;644.1272076336567;654.3227759269157;667.7762949411953;675.8580698053414;677.4174210179242;550.6393312380397;566.1027271774243;653.947684185264;666.1805978646267;668.0480315550345;701.6281370873445;709.7977076533189;710.0378986473331;711.4415184080498;711.5410560188701;702.9437644988415;702.9578225306473;706.9505134640577;707.2008630247788;707.971681132754;422.3369310183014;427.6856510464806;499.9550040496373;517.0718560184478;517.5833454069473;12156.51373945041;12652.430640621194;12660.17708848922;12661.113722039461;12661.240325580402;11793.528258869635;11884.40577971098;11991.700207494796;12189.207701499374;12352.814707779391;11885;12099.818502722466;12117.394130293538;12122.757544849143;12295.139340246187;4039.9192016159514;4061.451704019949;4071.5521292657786;4133.545310015896;4200.432941552882;62422.37577624211;62600.373996260365;63107.68446157786;63704.681476592785;64576;9725.951370243103;9805.705828825146;9825.950870245602;9835.704928852147;10106.242031847642;16445.342186312413;16465.094419807025;16479.91760041192;16508.422205223;17468.47594572165;7450.366718828852;7470.70117195317;7471;7566.470347075762;7636.618169091523;4166.208420400114;4207.537170911197;4257.318828987347;4300.4839419269265;4408.360787685768;3009.473342165112;3112.237501812025;3112.4086423579447;3114.423831591163;3114.78196526241;536.1207619504016;554.938956714761;556.9832905012856;559.8488408129864;560.5907687388229;658.8221180281297;672.6065251827736;696.6551556979327;700.5691499727631;703.9472039597051;8816.691415800544;8822.294216462667;9081.318901082444;9224.30817688676;9231.723048308562;629.529098289213;641.960024759892;646.3084499585399;652.641047423915;679.826520181419;4047.8785636430953;4101.938470922939;4129.876103716833;4135.0902801383645;4201.852935147316;66823.33176668172;70577.94133088007;71379.64310178415;71609.64195179095;72123.63938180276;60539.39460605338;61661.38338616646;63210;63463.36536634667;63872.68063659652;55949.72025139848;56004.439955600734;56097.43902561004;56384.43615563874;56601.43398566044;7956.403269754907;8027.237412445808;8189.79525511867;8230.300424463987;8282.627281772455;35250.647493525765;37071.258574827814;37670.434943476415;38901.805490972365;39338.606613933494;47867;48378.5162148374;50742.49257507525;52371.73814130905;53770;10788.568457261621;11061.502232399722;11335.716607084889;11354.54581816718;11784;12889.226646401246;13436.865631343953;13661.043726939019;13709.314534273446;13835.58493245164;12326.32205228721;12790.232586044867;13018.80471792905;13150.27673477968;13399.598012059654;12218.633440996784;12388.56640017595;12425.689357766129;12546.309952952675;12739.61781146567;12263.570775022832;12288.938555307166;12315.876841231473;12355.3822308886;12439.937800311303;9995.950020249853;10532.631357902437;10784.245102842726;10841.837372439577;10926.399048052433;10267.537960791633;10511.211659125443;10626.468676566295;10824.188185885932;10883.401412922365 20:47:54 INFO - PROCESS | 3424 | __end_tp_report 20:47:54 INFO - PROCESS | 3424 | __start_cc_report 20:47:54 INFO - PROCESS | 3424 | _x_x_mozilla_cycle_collect,1419 20:47:54 INFO - PROCESS | 3424 | __end_cc_report 20:47:54 INFO - PROCESS | 3424 | __startTimestamp1477540074303__endTimestamp 20:47:54 INFO - PROCESS | 3424 | 20:47:54 INFO - PROCESS | 3424 | ------- Summary: start ------- 20:47:54 INFO - PROCESS | 3424 | Number of tests: 6 20:47:54 INFO - PROCESS | 3424 | 20:47:54 INFO - PROCESS | 3424 | [#0] dojo.html Cycles:165 Average:5021.72 Median:5325.47 stddev:674.69 (12.7%) stddev-sans-first:654.27 20:47:54 INFO - PROCESS | 3424 | Values: 2819.9 2830.3 2864.0 2868.4 2872.2 4933.6 4992.2 5011.4 5042.4 5062.9 4970.3 5002.0 5017.3 5019.2 5055.1 4565.2 4569.4 4581.3 4581.7 4641.4 4598.0 4605.8 4633.3 4639.1 4643.4 4593.1 4605.8 4628.1 4630.7 4661.0 4604.4 4642.6 4669.2 4680.9 4747.0 4511.1 4614.4 4615.5 4655.1 4657.8 4944.8 5027.1 5054.8 5093.2 5096.9 5480.3 5489.1 5496.6 5510.1 5540.9 5573.0 5581.1 5591.1 5599.9 5638.6 4906.0 4976.1 4978.6 5036.9 5094.9 5541.1 5593.7 5627.5 5628.2 5664.7 5290.8 5358.1 5365.3 5365.5 5373.8 5325.5 5378.2 5380.2 5460.7 5548.3 5361.0 5374.1 5375.4 5377.4 5378.2 5352.5 5369.6 5370.9 5377.6 5379.5 3524.1 3549.9 3552.1 3559.0 3581.0 3208.5 3221.4 3250.4 3269.8 3286.4 5223.4 5228.4 5233.8 5244.3 5286.0 5247.5 5249.2 5264.8 5452.6 5457.4 5053.3 5092.5 5095.1 5099.5 5100.4 4348.5 4369.7 4385.6 4394.3 4399.6 5452.0 5454.4 5458.9 5466.9 5466.9 5325.8 5327.4 5328.2 5534.9 5553.3 5715.8 5724.1 5726.2 5746.7 5784.4 5462.7 5472.0 5473.8 5474.5 5475.0 5471.7 5551.1 5567.6 5575.4 5639.8 5261.1 5346.1 5387.8 5418.5 5465.5 5359.3 5363.9 5401.4 5402.2 5405.4 5164.7 5413.9 5432.2 5434.2 5496.7 5271.4 5330.7 5430.0 5459.5 5466.6 5394.0 5426.7 5429.1 5438.4 5461.9 20:47:54 INFO - PROCESS | 3424 | 20:47:54 INFO - PROCESS | 3424 | [#1] ext.html Cycles:180 Average:47788.12 Median:33863.41 stddev:92196.36 (272.3%) stddev-sans-first:92386.75 20:47:54 INFO - PROCESS | 3424 | Values: 542.4 570.6 572.7 580.2 590.6 27968.7 36805.4 38012.2 38064.0 41278.6 36994.4 37855.4 37969.2 38146.6 38151.6 8115.6 8183.8 8257.3 8264.7 8275.2 7338.0 7513.2 9832.2 10023.1 10091.6 10041.4 10114.5 10114.5 10160.3 10165.2 7146.4 7294.6 9876.2 9886.6 9916.0 9509.9 9867.3 9871.5 10001.3 10011.6 36080.3 36168.5 36336.5 36400.6 36481.0 3080.7 3088.3 3088.3 3135.1 3257.5 28508.0 28602.3 28892.3 29288.1 29583.0 3960.9 3989.8 4002.8 4018.1 4090.5 293478.0 293960.0 294188.0 296403.0 296429.0 28321.9 47748.3 48028.3 48071.8 48088.0 27080.9 28159.2 28238.4 28256.7 28262.3 12751.4 12873.0 12897.2 12903.8 12923.2 10133.2 10408.6 10887.0 10912.7 10957.0 6287.8 6430.2 6430.3 6442.3 6509.7 2581.3 2587.8 2609.8 2612.4 2647.5 825.9 875.3 880.2 911.9 919.4 26510.7 27242.5 27529.2 27893.3 28134.9 882.2 924.4 946.3 979.6 1028.6 14145.9 14222.2 14246.0 14402.0 14456.7 405890.0 409842.0 410022.0 410358.0 412523.0 47929.8 48198.8 48327.3 48362.0 48363.0 1050.7 1086.5 1117.4 1147.5 1152.1 25615.6 27620.6 27787.7 28074.3 28454.3 40590.4 40994.4 41006.4 41010.2 41053.0 331475.0 331498.0 331541.0 331811.0 332051.0 23669.9 24370.8 25183.1 25196.7 26326.7 40610.4 41200.0 41223.4 41258.0 41294.6 34121.1 34602.3 34656.8 35021.3 35260.5 34024.3 34948.5 34992.1 35140.8 35791.5 33512.8 33573.2 33620.8 33702.5 34377.1 30760.2 31318.1 31389.5 31538.4 31552.5 23754.2 23770.6 24020.4 24254.2 24387.0 20:47:54 INFO - PROCESS | 3424 | 20:47:54 INFO - PROCESS | 3424 | [#2] jquery.html Cycles:180 Average:24589.14 Median:4622.48 stddev:65429.95 (1415.5%) stddev-sans-first:65588.13 20:47:54 INFO - PROCESS | 3424 | Values: 323.8 340.5 341.1 341.6 352.1 13166.3 14096.1 16612.1 17050.8 17823.9 16206.5 16483.5 16722.7 16758.7 16785.3 4312.9 5149.9 5394.8 5400.8 5409.1 5252.4 5361.7 5369.4 5376.9 5395.8 5090.8 5283.6 5315.4 5316.7 5317.2 5247.6 5264.5 5268.9 5275.9 5296.2 4449.9 4592.4 4620.3 4624.7 4656.2 19843.3 19957.7 20265.4 20435.9 20706.8 2018.9 2046.7 2054.9 2457.6 2718.4 12410.8 12441.6 12504.0 12542.3 13399.2 1734.5 1749.8 1784.0 1785.1 1808.9 57355.4 59322.1 63518.0 70742.3 73375.6 8731.8 9159.1 9333.9 9381.2 9494.0 12680.8 12689.0 12690.4 12705.6 12711.0 6944.9 7154.1 7184.1 7240.7 7275.5 7006.2 7034.4 7102.5 7145.5 7151.1 5755.4 5830.4 5848.6 5862.8 5948.5 1602.8 1670.8 1678.2 1681.2 1684.2 812.7 857.3 860.5 904.2 914.2 16953.7 17159.8 17362.2 17488.3 17641.9 859.6 866.1 877.7 895.7 920.5 9481.7 9662.8 9751.1 9850.0 9869.0 384032.0 396812.0 397890.0 398946.0 399628.0 73764.3 80185.6 90994.0 91656.0 93594.0 858.4 880.5 883.6 884.0 896.1 14964.7 15175.4 15229.2 15486.2 15711.1 35758.6 36334.3 36777.3 36803.6 37234.3 48256.8 50911.2 51933.2 52127.2 54021.5 7220.3 7375.9 7584.8 7655.4 7658.1 10461.6 11279.8 11838.6 11857.0 11946.3 10084.0 10087.5 10325.9 10334.2 10497.8 9964.4 10035.6 10184.2 10322.6 10328.0 10034.8 10085.0 10361.4 10434.6 10522.6 7448.9 7463.9 7480.6 7495.6 7762.4 7865.0 9834.0 10080.4 10093.6 10614.8 20:47:54 INFO - PROCESS | 3424 | 20:47:54 INFO - PROCESS | 3424 | [#3] mootools.html Cycles:180 Average:4760.79 Median:5952.45 stddev:2717.35 (45.7%) stddev-sans-first:2711.17 20:47:54 INFO - PROCESS | 3424 | Values: 1115.7 1140.2 1144.2 1234.6 1395.7 6477.1 7165.5 7445.1 7447.3 7470.8 7410.7 7450.7 7457.0 7464.7 7481.6 1960.1 1985.2 1985.4 1987.2 1987.7 1960.2 1984.3 1990.0 1998.3 2002.5 1945.8 1960.5 1969.2 1975.3 1975.9 1880.9 1893.0 1894.8 1896.5 1898.7 1875.8 1883.1 1888.3 1914.6 1919.2 7026.8 7061.8 7252.5 7396.0 7435.8 4397.5 4530.3 4555.6 4568.3 4573.7 2856.2 2996.2 3051.8 3054.8 3059.8 922.2 947.9 949.5 955.3 958.4 10075.3 10187.5 10191.5 10255.0 10269.3 3680.9 3756.9 3775.3 3778.5 3800.7 7886.8 7906.5 7908.5 7909.8 7919.1 4429.4 4437.1 4438.7 4441.7 4454.5 3499.8 3730.1 3749.2 4191.6 4197.4 3105.4 3139.4 3187.4 3188.3 3188.3 896.1 904.9 906.8 912.7 915.8 734.5 749.7 760.8 780.4 783.0 4568.2 4677.5 4744.5 4798.3 4873.4 732.5 770.2 800.2 805.6 811.3 3143.7 3158.3 3164.7 3233.9 3324.0 8854.8 9022.0 9103.5 9117.9 9159.6 9021.6 9046.4 9046.6 9085.9 9106.4 6613.4 6731.7 6738.3 6759.1 6789.1 4528.8 4569.2 4596.8 4701.5 4717.1 8066.7 8097.2 8141.7 8196.6 8204.3 7638.1 7942.5 8190.4 8366.4 8403.7 5879.1 6058.5 6078.1 6121.6 6142.3 7326.6 7350.1 7383.5 7428.8 7431.2 6615.2 6623.5 6661.5 6689.5 6693.5 6426.1 6456.8 6538.0 6554.2 6587.9 6025.8 6065.6 6121.7 6124.7 6129.4 3940.2 3961.4 4009.2 4012.7 4041.8 3889.8 3913.2 3955.5 3991.7 4060.7 20:47:54 INFO - PROCESS | 3424 | 20:47:54 INFO - PROCESS | 3424 | [#4] prototype.html Cycles:180 Average:4486.02 Median:5264.28 stddev:1352.37 (25.7%) stddev-sans-first:1318.75 20:47:54 INFO - PROCESS | 3424 | Values: 277.3 283.1 287.8 288.3 290.9 5113.0 5120.0 5159.8 5162.8 5185.3 4839.5 4924.7 5005.3 5045.8 5080.4 3912.2 3922.9 3931.0 3935.6 3942.8 3907.1 3933.7 3948.2 3950.4 3953.8 3710.4 3747.9 3883.4 3905.0 3926.9 3884.4 3888.6 3891.9 3895.2 3899.3 3433.3 3439.1 3446.8 3446.8 3452.6 4842.2 4917.3 5010.0 5023.7 5042.2 4535.8 4537.8 4539.3 4541.8 4551.0 5289.8 5364.5 5366.6 5377.0 5389.4 3452.3 3650.5 3801.7 3805.9 3806.7 5587.2 5587.4 5598.3 5600.5 5602.5 3762.4 3767.6 3775.0 3778.5 3780.1 3820.7 3825.1 3825.8 3840.3 3840.3 4232.9 4414.6 4462.4 4472.6 4475.3 5369.6 5373.7 5395.3 5399.8 5429.0 1265.3 1313.5 1329.2 1336.8 1337.4 838.3 863.6 882.4 885.9 894.4 5307.8 5314.6 5316.6 5322.5 5337.0 5538.3 5541.5 5558.3 5565.8 5569.6 5090.3 5275.9 5306.8 5307.7 5319.9 2937.3 2942.7 2948.8 2951.4 2964.2 5422.2 5603.0 5657.5 5666.8 5669.0 5576.5 5582.3 5584.6 5592.4 5599.8 5644.2 5645.8 5661.2 5672.0 5674.9 5263.6 5452.6 5474.6 5497.0 5523.5 5367.9 5391.6 5392.7 5397.8 5409.4 5407.7 5647.5 5650.2 5651.4 5661.6 3700.4 3730.7 3730.8 3741.7 3750.3 5295.5 5511.9 5529.9 5533.6 5536.3 5224.4 5336.2 5378.1 5386.2 5387.5 5298.6 5326.6 5357.6 5360.6 5368.5 5060.9 5168.7 5232.3 5264.9 5276.4 5422.6 5435.4 5445.7 5449.6 5458.3 5360.3 5365.5 5367.5 5381.2 5387.2 20:47:54 INFO - PROCESS | 3424 | 20:47:54 INFO - PROCESS | 3424 | [#5] yui.html Cycles:180 Average:15600.62 Median:4354.42 stddev:19611.96 (450.4%) stddev-sans-first:19634.70 20:47:54 INFO - PROCESS | 3424 | Values: 616.2 709.6 718.5 721.5 732.8 13352.7 13995.9 14190.1 14210.6 14727.2 13342.0 13750.0 13751.0 13756.4 13838.8 644.1 654.3 667.8 675.9 677.4 550.6 566.1 653.9 666.2 668.0 701.6 709.8 710.0 711.4 711.5 702.9 703.0 707.0 707.2 708.0 422.3 427.7 500.0 517.1 517.6 12156.5 12652.4 12660.2 12661.1 12661.2 11793.5 11884.4 11991.7 12189.2 12352.8 11885.0 12099.8 12117.4 12122.8 12295.1 4039.9 4061.5 4071.6 4133.5 4200.4 62422.4 62600.4 63107.7 63704.7 64576.0 9726.0 9805.7 9826.0 9835.7 10106.2 16445.3 16465.1 16479.9 16508.4 17468.5 7450.4 7470.7 7471.0 7566.5 7636.6 4166.2 4207.5 4257.3 4300.5 4408.4 3009.5 3112.2 3112.4 3114.4 3114.8 536.1 554.9 557.0 559.8 560.6 658.8 672.6 696.7 700.6 703.9 8816.7 8822.3 9081.3 9224.3 9231.7 629.5 642.0 646.3 652.6 679.8 4047.9 4101.9 4129.9 4135.1 4201.9 66823.3 70577.9 71379.6 71609.6 72123.6 60539.4 61661.4 63210.0 63463.4 63872.7 55949.7 56004.4 56097.4 56384.4 56601.4 7956.4 8027.2 8189.8 8230.3 8282.6 35250.6 37071.3 37670.4 38901.8 39338.6 47867.0 48378.5 50742.5 52371.7 53770.0 10788.6 11061.5 11335.7 11354.5 11784.0 12889.2 13436.9 13661.0 13709.3 13835.6 12326.3 12790.2 13018.8 13150.3 13399.6 12218.6 12388.6 12425.7 12546.3 12739.6 12263.6 12288.9 12315.9 12355.4 12439.9 9996.0 10532.6 10784.2 10841.8 10926.4 10267.5 10511.2 10626.5 10824.2 10883.4 20:47:54 INFO - PROCESS | 3424 | -------- Summary: end -------- 20:47:54 INFO - PROCESS | 3424 | 20:47:55 INFO - TEST-INFO | 3424: exit 0 20:47:55 INFO - TEST-OK | dromaeo_css | took 1123563ms 20:47:55 INFO - TEST-START | kraken 20:47:55 INFO - operating with platform_type : w8_ 20:47:55 INFO - Initialising browser for kraken test... 20:47:55 INFO - TEST-INFO | started process 1564 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp1tjha0\profile http://localhost:49276/getInfo.html) 20:48:00 INFO - PROCESS | 1564 | __metrics Screen width/height:1600/1200 20:48:00 INFO - PROCESS | 1564 | colorDepth:24 20:48:00 INFO - PROCESS | 1564 | Browser inner width/height: 1010/674 20:48:00 INFO - PROCESS | 1564 | __metrics 20:48:01 INFO - PROCESS | 1564 | 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" 20:48:01 INFO - PROCESS | 1564 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:48:02 INFO - PROCESS | 1564 | console.error: 20:48:02 INFO - PROCESS | 1564 | Message: Error: Connection closed before committing the transaction. 20:48:02 INFO - PROCESS | 1564 | Stack: 20:48:02 INFO - PROCESS | 1564 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 20:48:02 INFO - PROCESS | 1564 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 20:48:02 INFO - PROCESS | 1564 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 20:48:02 INFO - PROCESS | 1564 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 20:48:02 INFO - PROCESS | 1564 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 20:48:02 INFO - PROCESS | 1564 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 20:48:02 INFO - PROCESS | 1564 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 20:48:02 INFO - PROCESS | 1564 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 20:48:02 INFO - PROCESS | 1564 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 20:48:02 INFO - PROCESS | 1564 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 20:48:02 INFO - PROCESS | 1564 | Barrier/this.client.addBlocker/promise13.4% 20:48:59 INFO - TinderboxPrint: I/O read bytes / time
189,000,192 / 1,753,120 20:48:59 INFO - TinderboxPrint: I/O write bytes / time
410,767,360 / 3,632,070 20:48:59 INFO - TinderboxPrint: CPU idle
8,266.9 (86.7%) 20:48:59 INFO - TinderboxPrint: CPU user
1,223.0 (12.8%) 20:48:59 INFO - install - Wall time: 3s; CPU: 10.0%; Read bytes: 0; Write bytes: 37860352; Read time: 0; Write time: 77360 20:48:59 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 189000192; Write bytes: 317111296; Read time: 1753120; Write time: 3498440 20:48:59 INFO - Running post-run listener: _upload_blobber_files 20:48:59 INFO - Blob upload gear active. 20:48:59 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 20:48:59 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 20:48:59 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', 'Autoland', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 20:48:59 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 Autoland -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 20:49:00 INFO - (blobuploader) - INFO - Open directory for files ... 20:49:00 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 20:49:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:49:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:49:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:49:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:49:00 INFO - (blobuploader) - INFO - Done attempting. 20:49:00 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 20:49:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:49:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:49:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:49:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:49:01 INFO - (blobuploader) - INFO - Done attempting. 20:49:01 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 20:49:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:49:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:49:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:49:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:49:03 INFO - (blobuploader) - INFO - Done attempting. 20:49:03 INFO - (blobuploader) - INFO - Iteration through files over. 20:49:03 INFO - Return code: 0 20:49:03 INFO - rmtree: C:\slave\test\build\uploaded_files.json 20:49:03 INFO - Using _rmtree_windows ... 20:49:03 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 20:49:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/79161ba028f62a8f08ba530f3d4e217c8df1e3215549616c2897d053c72c4df7ca691cb21c8c4485a73e4e0178742c14aa96e72d4f853969fbb7fc7f99b78505", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/400bb1f7134bb86b44060c3ac192370d5a1fca8f491c9c816123d439660f513080afd58ee994c605e913927762713d521cfba7548d47093aa809e826026470cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e28c68b44559a8dcd9dc82847b872a6a4aeabcf02da1f5779804da08f2d66f2928ff1f718b82d320789d7ce3c60b9d474ec9dc575705bef74b2da8dda310e53b"} 20:49:03 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 20:49:03 INFO - Writing to file C:\slave\test\properties\blobber_files 20:49:03 INFO - Contents: 20:49:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/79161ba028f62a8f08ba530f3d4e217c8df1e3215549616c2897d053c72c4df7ca691cb21c8c4485a73e4e0178742c14aa96e72d4f853969fbb7fc7f99b78505", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/400bb1f7134bb86b44060c3ac192370d5a1fca8f491c9c816123d439660f513080afd58ee994c605e913927762713d521cfba7548d47093aa809e826026470cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e28c68b44559a8dcd9dc82847b872a6a4aeabcf02da1f5779804da08f2d66f2928ff1f718b82d320789d7ce3c60b9d474ec9dc575705bef74b2da8dda310e53b"} 20:49:03 INFO - Running post-run listener: copy_logs_to_upload_dir 20:49:03 INFO - Copying logs to upload dir... 20:49:03 INFO - mkdir: C:\slave\test\build\upload\logs 20:49:03 INFO - Copying logs to upload dir... 20:49:03 INFO - Using _rmtree_windows ... 20:49:03 INFO - Using _rmtree_windows ... 20:49:03 INFO - Using _rmtree_windows ... 20:49:03 INFO - Using _rmtree_windows ... 20:49:03 INFO - Using _rmtree_windows ... 20:49:03 INFO - Using _rmtree_windows ... 20:49:03 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1388.707000 ========= master_lag: 0.16 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 8 secs) (at 2016-10-26 20:49:04.001756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 20:49:04.002492) ========= '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-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/79161ba028f62a8f08ba530f3d4e217c8df1e3215549616c2897d053c72c4df7ca691cb21c8c4485a73e4e0178742c14aa96e72d4f853969fbb7fc7f99b78505", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/400bb1f7134bb86b44060c3ac192370d5a1fca8f491c9c816123d439660f513080afd58ee994c605e913927762713d521cfba7548d47093aa809e826026470cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e28c68b44559a8dcd9dc82847b872a6a4aeabcf02da1f5779804da08f2d66f2928ff1f718b82d320789d7ce3c60b9d474ec9dc575705bef74b2da8dda310e53b"} build_url:https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/XJQXESk1RSSCtiHwXcdwrA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/79161ba028f62a8f08ba530f3d4e217c8df1e3215549616c2897d053c72c4df7ca691cb21c8c4485a73e4e0178742c14aa96e72d4f853969fbb7fc7f99b78505", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/400bb1f7134bb86b44060c3ac192370d5a1fca8f491c9c816123d439660f513080afd58ee994c605e913927762713d521cfba7548d47093aa809e826026470cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e28c68b44559a8dcd9dc82847b872a6a4aeabcf02da1f5779804da08f2d66f2928ff1f718b82d320789d7ce3c60b9d474ec9dc575705bef74b2da8dda310e53b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 20:49:04.124143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:49:04.124470) ========= '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-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 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-26 20:49:04.242856) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-26 20:49:04.243198) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-26 20:49:04.712057) ========= ========= Total master_lag: 4.05 =========