builder: mozilla-central_win8_64_test-dromaeojs-pgo slave: t-w864-ix-066 starttime: 1476464620.79 results: success (0) buildid: 20161014060324 builduid: cc12e163b33e4b2fb41aa379f63cd7aa revision: 0c899672fff6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 10:03:40.789005) ========= master: http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 10:03:40.789471) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 10:03:40.789761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 10:03:40.975080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-14 10:03:40.975454) ========= '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-066\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-066 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-066 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-066\AppData\Local LOGONSERVER=\\T-W864-IX-066 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-066 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-066 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-066 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --10:03:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure HTTP request sent, awaiting response... 200 Script output follows Length: 12,179 (12K) [text/x-python] 0K .......... . 100% 8.41 MB/s 10:03:43 (8.41 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=2.606000 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-14 10:03:43.670358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-10-14 10:03:43.670713) ========= '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-066\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-066 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-066 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-066\AppData\Local LOGONSERVER=\\T-W864-IX-066 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-066 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-066 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-066 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=5.413000 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-10-14 10:03:49.097811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-14 10:03:49.098169) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev 0c899672fff6 --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0c899672fff6 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-066\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-066 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-066 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-066\AppData\Local LOGONSERVER=\\T-W864-IX-066 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-066 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-066 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-066 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-14 10:03:49,993 Setting DEBUG logging. 2016-10-14 10:03:49,994 attempt 1/10 2016-10-14 10:03:49,994 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0c899672fff6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 10:03:50,867 unpacking tar archive at: mozilla-central-0c899672fff6/testing/mozharness/ 2016-10-14 10:03:51,082 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=2.666000 ========= master_lag: 0.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-14 10:03:52.085421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 10:03:52.085753) ========= script_repo_revision: 0c899672fff6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 10:03:52.086185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 10:03:52.086470) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 10:03:52.104154) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 9 secs) (at 2016-10-14 10:03:52.104447) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Firefox' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Firefox' in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-066\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-066 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-066 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-066\AppData\Local LOGONSERVER=\\T-W864-IX-066 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-066 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-066 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-066 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 10:03:52 INFO - MultiFileLogger online at 20161014 10:03:52 in C:\slave\test 10:03:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:03:52 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 10:03:52 INFO - {'append_to_log': False, 10:03:52 INFO - 'base_work_dir': 'C:\\slave\\test', 10:03:52 INFO - 'blob_upload_branch': 'Firefox', 10:03:52 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 10:03:52 INFO - 'branch': 'Firefox', 10:03:52 INFO - 'buildbot_json_path': 'buildprops.json', 10:03:52 INFO - 'config_files': ('talos/windows_config.py',), 10:03:52 INFO - 'default_actions': ('clobber', 10:03:52 INFO - 'read-buildbot-config', 10:03:52 INFO - 'download-and-extract', 10:03:52 INFO - 'populate-webroot', 10:03:52 INFO - 'create-virtualenv', 10:03:52 INFO - 'install', 10:03:52 INFO - 'run-tests'), 10:03:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:03:52 INFO - 'download_minidump_stackwalk': True, 10:03:52 INFO - 'download_symbols': 'ondemand', 10:03:52 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 10:03:52 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 10:03:52 INFO - 'hg': 'c:/mozilla-build/hg/hg', 10:03:52 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 10:03:52 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 10:03:52 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 10:03:52 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 10:03:52 INFO - 'C:/mozilla-build/tooltool.py'), 10:03:52 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 10:03:52 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 10:03:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:03:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:03:52 INFO - 'installer_path': 'installer.exe', 10:03:52 INFO - 'log_level': 'info', 10:03:52 INFO - 'log_name': 'talos', 10:03:52 INFO - 'log_to_console': True, 10:03:52 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 10:03:52 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 10:03:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 10:03:52 INFO - 'opt_config_files': (), 10:03:52 INFO - 'pip_index': False, 10:03:52 INFO - 'sps_profile': False, 10:03:52 INFO - 'sps_profile_interval': 0, 10:03:52 INFO - 'suite': 'dromaeojs', 10:03:52 INFO - 'system_bits': '32', 10:03:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:03:52 INFO - 'title': 'T-W864-IX-066', 10:03:52 INFO - 'use_talos_json': True, 10:03:52 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 10:03:52 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 10:03:52 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 10:03:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:03:52 INFO - 'work_dir': 'build'} 10:03:52 INFO - [mozharness: 2016-10-14 17:03:52.701000Z] Running clobber step. 10:03:52 INFO - Running pre-action listener: _resource_record_pre_action 10:03:52 INFO - Running main action method: clobber 10:03:52 INFO - rmtree: C:\slave\test\build 10:03:52 INFO - Using _rmtree_windows ... 10:03:52 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 10:06:21 INFO - Running post-action listener: _resource_record_post_action 10:06:21 INFO - [mozharness: 2016-10-14 17:06:21.324000Z] Finished clobber step (success) 10:06:21 INFO - [mozharness: 2016-10-14 17:06:21.324000Z] Running read-buildbot-config step. 10:06:21 INFO - Running pre-action listener: _resource_record_pre_action 10:06:21 INFO - Running main action method: read_buildbot_config 10:06:21 INFO - Using buildbot properties: 10:06:21 INFO - { 10:06:21 INFO - "project": "", 10:06:21 INFO - "product": "firefox", 10:06:21 INFO - "script_repo_revision": "production", 10:06:21 INFO - "builddir": "mozilla-central_win8_64_test-dromaeojs", 10:06:21 INFO - "repository": "", 10:06:21 INFO - "buildername": "Windows 8 64-bit mozilla-central pgo talos dromaeojs", 10:06:21 INFO - "buildid": "20161014060324", 10:06:21 INFO - "stage_platform": "win64-pgo", 10:06:21 INFO - "basedir": "C:\\slave\\test", 10:06:21 INFO - "nightly_build": "True", 10:06:21 INFO - "buildnumber": 36, 10:06:21 INFO - "slavename": "t-w864-ix-066", 10:06:21 INFO - "master": "http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/", 10:06:21 INFO - "platform": "win8_64", 10:06:21 INFO - "scheduler": "tests-mozilla-central-win64-pgo-talos", 10:06:21 INFO - "branch": "mozilla-central", 10:06:21 INFO - "repo_path": "mozilla-central", 10:06:21 INFO - "revision": "0c899672fff6", 10:06:21 INFO - "pgo_build": "True", 10:06:21 INFO - "builduid": "cc12e163b33e4b2fb41aa379f63cd7aa", 10:06:21 INFO - "slavebuilddir": "test" 10:06:21 INFO - } 10:06:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 10:06:21 INFO - Running post-action listener: _resource_record_post_action 10:06:21 INFO - [mozharness: 2016-10-14 17:06:21.327000Z] Finished read-buildbot-config step (success) 10:06:21 INFO - [mozharness: 2016-10-14 17:06:21.328000Z] Running download-and-extract step. 10:06:21 INFO - Running pre-action listener: _resource_record_pre_action 10:06:21 INFO - Running main action method: download_and_extract 10:06:21 INFO - mkdir: C:\slave\test\build\tests 10:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:21 INFO - trying https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 10:06:21 INFO - Downloading https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/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 10:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/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 10:06:22 INFO - Downloaded 1218 bytes. 10:06:22 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 10:06:22 INFO - Using the following test package requirements: 10:06:22 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 10:06:22 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:06:22 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 10:06:22 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 10:06:22 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:06:22 INFO - u'jsshell-win64.zip'], 10:06:22 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:06:22 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 10:06:22 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 10:06:22 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:06:22 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 10:06:22 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:06:22 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 10:06:22 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:06:22 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 10:06:22 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:06:22 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 10:06:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 10:06:22 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 10:06:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 10:06:22 INFO - Fetch https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 10:06:22 INFO - Http code: 200 10:06:22 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 10:06:22 INFO - x-amz-cf-id: goSFhaXIrHy2pI0L3pheD-JprxYuVB3vdVAfSl8j0MgppZIqWtFnKg== 10:06:22 INFO - x-amz-version-id: 85l71qAn6w1v0maWf14JLy0edzrnTnYa 10:06:23 INFO - Expected file size: 17558697 10:06:23 INFO - Obtained file size: 17558697 10:06:45 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 10:06:45 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 10:06:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 10:06:45 INFO - Fetch https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 10:06:45 INFO - Http code: 200 10:06:45 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 10:06:45 INFO - x-amz-cf-id: oIfJ5ZdsYd8FX9PkAJUUrtW2VmAzJ3JRZKpzf_GkJo2EvEOEo3Lylg== 10:06:45 INFO - x-amz-version-id: 85l71qAn6w1v0maWf14JLy0edzrnTnYa 10:06:46 INFO - Expected file size: 17558697 10:06:46 INFO - Obtained file size: 17558697 10:06:57 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 10:06:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 10:06:57 INFO - Fetch https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 10:06:57 INFO - Http code: 200 10:06:57 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 10:06:57 INFO - x-amz-cf-id: 5tL_kzCmRBrayTgaPD7cRGvvrqF-9wi7ZkQb8uGcajSuWmMAy441fQ== 10:06:57 INFO - x-amz-version-id: N2QVeMEa6M.TusV2TwVToN5C2fqKujwf 10:06:57 INFO - Expected file size: 14409006 10:06:57 INFO - Obtained file size: 14409006 10:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:02 INFO - trying https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 10:07:02 INFO - Downloading https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 10:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/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 10:07:03 INFO - Downloaded 57389520 bytes. 10:07:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 10:07:03 INFO - mkdir: C:\slave\test\properties 10:07:03 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 10:07:03 INFO - Writing to file C:\slave\test\properties\build_url 10:07:03 INFO - Contents: 10:07:03 INFO - build_url:https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 10:07:04 INFO - Running post-action listener: _resource_record_post_action 10:07:04 INFO - Running post-action listener: set_extra_try_arguments 10:07:04 INFO - [mozharness: 2016-10-14 17:07:04.645000Z] Finished download-and-extract step (success) 10:07:04 INFO - [mozharness: 2016-10-14 17:07:04.645000Z] Running populate-webroot step. 10:07:04 INFO - Running pre-action listener: _resource_record_pre_action 10:07:04 INFO - Running main action method: populate_webroot 10:07:04 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 10:07:04 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 10:07:04 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 10:07:04 INFO - u'--tppagecycles', 10:07:04 INFO - u'7'], 10:07:04 INFO - u'tests': [u'tsvgm']}}, 10:07:04 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 10:07:04 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 10:07:04 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 10:07:04 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 10:07:04 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 10:07:04 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 10:07:04 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:04 INFO - u'talos_options': [u'--disable-e10s'], 10:07:04 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 10:07:04 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:04 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 10:07:04 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:04 INFO - u'talos_options': [u'--disable-e10s'], 10:07:04 INFO - u'tests': [u'damp', u'tps']}, 10:07:04 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:04 INFO - u'tests': [u'damp', u'tps']}, 10:07:04 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 10:07:04 INFO - u'tests': [u'dromaeo_dom']}, 10:07:04 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 10:07:04 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 10:07:04 INFO - u'tests': [u'basic_compositor_video']}, 10:07:04 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 10:07:04 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 10:07:04 INFO - u'tests': [u'a11yr', 10:07:04 INFO - u'ts_paint', 10:07:04 INFO - u'tpaint', 10:07:04 INFO - u'sessionrestore', 10:07:04 INFO - u'sessionrestore_no_auto_restore', 10:07:04 INFO - u'tabpaint']}, 10:07:04 INFO - u'other-e10s': {u'tests': [u'a11yr', 10:07:04 INFO - u'ts_paint', 10:07:04 INFO - u'tpaint', 10:07:04 INFO - u'sessionrestore', 10:07:04 INFO - u'sessionrestore_no_auto_restore', 10:07:04 INFO - u'tabpaint']}, 10:07:04 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 10:07:04 INFO - u'ts_paint', 10:07:04 INFO - u'tpaint', 10:07:04 INFO - u'sessionrestore', 10:07:04 INFO - u'sessionrestore_no_auto_restore', 10:07:04 INFO - u'tabpaint']}, 10:07:04 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 10:07:04 INFO - u'ts_paint', 10:07:04 INFO - u'tpaint', 10:07:04 INFO - u'sessionrestore', 10:07:04 INFO - u'sessionrestore_no_auto_restore', 10:07:04 INFO - u'tabpaint']}, 10:07:04 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 10:07:04 INFO - u'tests': [u'a11yr', 10:07:04 INFO - u'ts_paint', 10:07:04 INFO - u'tpaint', 10:07:04 INFO - u'sessionrestore', 10:07:04 INFO - u'sessionrestore_no_auto_restore', 10:07:04 INFO - u'tabpaint']}, 10:07:04 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 10:07:04 INFO - u'tests': [u'a11yr', 10:07:04 INFO - u'ts_paint', 10:07:04 INFO - u'tpaint', 10:07:04 INFO - u'sessionrestore', 10:07:04 INFO - u'sessionrestore_no_auto_restore', 10:07:04 INFO - u'tabpaint']}, 10:07:04 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 10:07:04 INFO - u'tests': [u'tsvgx', 10:07:04 INFO - u'tsvgr_opacity', 10:07:04 INFO - u'tart', 10:07:04 INFO - u'tscrollx', 10:07:04 INFO - u'cart']}, 10:07:04 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 10:07:04 INFO - u'tsvgr_opacity', 10:07:04 INFO - u'tart', 10:07:04 INFO - u'tscrollx', 10:07:04 INFO - u'cart']}, 10:07:04 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:04 INFO - u'talos_options': [u'--disable-e10s'], 10:07:04 INFO - u'tests': [u'tp5o']}, 10:07:04 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:04 INFO - u'tests': [u'tp5o']}, 10:07:04 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:04 INFO - u'talos_options': [u'--disable-e10s', 10:07:04 INFO - u'--xperf_path', 10:07:04 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:04 INFO - u'tests': [u'tp5n']}, 10:07:04 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:04 INFO - u'talos_options': [u'--xperf_path', 10:07:04 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:04 INFO - u'tests': [u'tp5n']}}, 10:07:04 INFO - u'talos.zip': {u'path': u'', 10:07:04 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:04 INFO - Running post-action listener: _resource_record_post_action 10:07:04 INFO - [mozharness: 2016-10-14 17:07:04.669000Z] Finished populate-webroot step (success) 10:07:04 INFO - [mozharness: 2016-10-14 17:07:04.669000Z] Running create-virtualenv step. 10:07:04 INFO - Running pre-action listener: _resource_record_pre_action 10:07:04 INFO - Running main action method: create_virtualenv 10:07:04 INFO - Creating virtualenv C:\slave\test\build/venv 10:07:04 INFO - mkdir: C:\slave\test\build\venv\Scripts 10:07:05 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 10:07:05 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'! 10:07:05 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 10:07:05 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 10:07:16 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 10:07:19 INFO - Installing distribute......................................................................................................................................................................................done. 10:07:20 INFO - Return code: 0 10:07:20 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 10:07:20 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 10:07:21 INFO - Reading from file tmpfile_stdout 10:07:21 INFO - Output received: 10:07:21 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 10:07:21 INFO - Using _rmtree_windows ... 10:07:21 INFO - Using _rmtree_windows ... 10:07:21 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 10:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:21 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 0x0245C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024DDE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028E4AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024B8E90>, '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 0x01EDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02924520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-066', 'USERDOMAIN': 'T-W864-IX-066', '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-066', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-066', '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-066\\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 10:07:21 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build 10:07:21 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:07:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:07:21 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Roaming', 10:07:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:07:21 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:07:21 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:07:21 INFO - 'COMPUTERNAME': 'T-W864-IX-066', 10:07:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:07:21 INFO - 'DCLOCATION': 'SCL3', 10:07:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:07:21 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:07:21 INFO - 'HOMEDRIVE': 'C:', 10:07:21 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 10:07:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:07:21 INFO - 'KTS_VERSION': '1.19c', 10:07:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 10:07:21 INFO - 'LOGONSERVER': '\\\\T-W864-IX-066', 10:07:21 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:07:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:21 INFO - 'MOZ_NO_REMOTE': '1', 10:07:21 INFO - 'NO_EM_RESTART': '1', 10:07:21 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:07:21 INFO - 'OS': 'Windows_NT', 10:07:21 INFO - 'OURDRIVE': 'C:', 10:07:21 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 10:07:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:07:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:07:21 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:07:21 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:07:21 INFO - 'PROCESSOR_LEVEL': '6', 10:07:21 INFO - 'PROCESSOR_REVISION': '1e05', 10:07:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:07:21 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:07:21 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:07:21 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:07:21 INFO - 'PROMPT': '$P$G', 10:07:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:07:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:07:21 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:07:21 INFO - 'PWD': 'C:\\slave\\test', 10:07:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:07:21 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:07:21 INFO - 'SYSTEMDRIVE': 'C:', 10:07:21 INFO - 'SYSTEMROOT': 'C:\\windows', 10:07:21 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:21 INFO - 'TEST1': 'testie', 10:07:21 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:21 INFO - 'USERDOMAIN': 'T-W864-IX-066', 10:07:21 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 10:07:21 INFO - 'USERNAME': 'cltbld', 10:07:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-066', 10:07:21 INFO - 'WINDIR': 'C:\\windows', 10:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:07:22 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:07:22 INFO - Downloading/unpacking pip>=1.5 10:07:26 INFO - Running setup.py egg_info for package pip 10:07:26 INFO - warning: no files found matching 'pip\cacert.pem' 10:07:26 INFO - warning: no files found matching '*.html' under directory 'docs' 10:07:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 10:07:26 INFO - no previously-included directories found matching 'docs\_build\_sources' 10:07:26 INFO - Installing collected packages: pip 10:07:26 INFO - Found existing installation: pip 0.8.2 10:07:26 INFO - Uninstalling pip: 10:07:26 INFO - Successfully uninstalled pip 10:07:26 INFO - Running setup.py install for pip 10:07:26 INFO - warning: no files found matching 'pip\cacert.pem' 10:07:26 INFO - warning: no files found matching '*.html' under directory 'docs' 10:07:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 10:07:26 INFO - no previously-included directories found matching 'docs\_build\_sources' 10:07:26 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 10:07:26 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 10:07:26 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 10:07:26 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 10:07:26 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 10:07:26 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 10:07:26 INFO - Successfully installed pip 10:07:26 INFO - Cleaning up... 10:07:26 INFO - Return code: 0 10:07:26 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 10:07:26 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')]} 10:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:26 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')]} 10:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:26 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 0x0245C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024DDE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028E4AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024B8E90>, '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 0x01EDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02924520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-066', 'USERDOMAIN': 'T-W864-IX-066', '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-066', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-066', '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-066\\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 10:07:26 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 10:07:26 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 10:07:26 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:07:26 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Roaming', 10:07:26 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:07:26 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:07:26 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:07:26 INFO - 'COMPUTERNAME': 'T-W864-IX-066', 10:07:26 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:07:26 INFO - 'DCLOCATION': 'SCL3', 10:07:26 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:07:26 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:07:26 INFO - 'HOMEDRIVE': 'C:', 10:07:26 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 10:07:26 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:07:26 INFO - 'KTS_VERSION': '1.19c', 10:07:26 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 10:07:26 INFO - 'LOGONSERVER': '\\\\T-W864-IX-066', 10:07:26 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:07:26 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:26 INFO - 'MOZ_NO_REMOTE': '1', 10:07:26 INFO - 'NO_EM_RESTART': '1', 10:07:26 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:07:26 INFO - 'OS': 'Windows_NT', 10:07:26 INFO - 'OURDRIVE': 'C:', 10:07:26 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;', 10:07:26 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:07:26 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:07:26 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:07:26 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:07:26 INFO - 'PROCESSOR_LEVEL': '6', 10:07:26 INFO - 'PROCESSOR_REVISION': '1e05', 10:07:26 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:07:26 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:07:26 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:07:26 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:07:26 INFO - 'PROMPT': '$P$G', 10:07:26 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:07:26 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:07:26 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:07:26 INFO - 'PWD': 'C:\\slave\\test', 10:07:26 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:07:26 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:07:26 INFO - 'SYSTEMDRIVE': 'C:', 10:07:26 INFO - 'SYSTEMROOT': 'C:\\windows', 10:07:26 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:26 INFO - 'TEST1': 'testie', 10:07:26 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:26 INFO - 'USERDOMAIN': 'T-W864-IX-066', 10:07:26 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 10:07:26 INFO - 'USERNAME': 'cltbld', 10:07:26 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-066', 10:07:26 INFO - 'WINDIR': 'C:\\windows', 10:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:28 INFO - Downloading/unpacking psutil>=3.1.1 10:07:28 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 10:07:28 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 10:07:29 INFO - Installing collected packages: psutil 10:07:29 INFO - Successfully installed psutil 10:07:29 INFO - Cleaning up... 10:07:29 INFO - Return code: 0 10:07:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 10:07: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')]} 10:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07: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')]} 10:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:29 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0245C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024DDE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028E4AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024B8E90>, '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 0x01EDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02924520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-066', 'USERDOMAIN': 'T-W864-IX-066', '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-066', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-066', '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-066\\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 10:07:29 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build 10:07:29 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:07:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:07:29 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Roaming', 10:07:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:07:29 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:07:29 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:07:29 INFO - 'COMPUTERNAME': 'T-W864-IX-066', 10:07:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:07:29 INFO - 'DCLOCATION': 'SCL3', 10:07:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:07:29 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:07:29 INFO - 'HOMEDRIVE': 'C:', 10:07:29 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 10:07:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:07:29 INFO - 'KTS_VERSION': '1.19c', 10:07:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 10:07:29 INFO - 'LOGONSERVER': '\\\\T-W864-IX-066', 10:07:29 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:07:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:29 INFO - 'MOZ_NO_REMOTE': '1', 10:07:29 INFO - 'NO_EM_RESTART': '1', 10:07:29 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:07:29 INFO - 'OS': 'Windows_NT', 10:07:29 INFO - 'OURDRIVE': 'C:', 10:07:29 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 10:07:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:07:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:07:29 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:07:29 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:07:29 INFO - 'PROCESSOR_LEVEL': '6', 10:07:29 INFO - 'PROCESSOR_REVISION': '1e05', 10:07:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:07:29 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:07:29 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:07:29 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:07:29 INFO - 'PROMPT': '$P$G', 10:07:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:07:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:07:29 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:07:29 INFO - 'PWD': 'C:\\slave\\test', 10:07:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:07:29 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:07:29 INFO - 'SYSTEMDRIVE': 'C:', 10:07:29 INFO - 'SYSTEMROOT': 'C:\\windows', 10:07:29 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:29 INFO - 'TEST1': 'testie', 10:07:29 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:29 INFO - 'USERDOMAIN': 'T-W864-IX-066', 10:07:29 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 10:07:29 INFO - 'USERNAME': 'cltbld', 10:07:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-066', 10:07:29 INFO - 'WINDIR': 'C:\\windows', 10:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:07:30 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 10:07:31 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) 10:07:31 INFO - Installing collected packages: mozsystemmonitor 10:07:31 INFO - Running setup.py install for mozsystemmonitor 10:07:31 INFO - Successfully installed mozsystemmonitor 10:07:31 INFO - Cleaning up... 10:07:31 INFO - Return code: 0 10:07:31 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 10:07: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')]} 10:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07: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')]} 10:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:31 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0245C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024DDE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028E4AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024B8E90>, '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 0x01EDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02924520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-066', 'USERDOMAIN': 'T-W864-IX-066', '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-066', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-066', '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-066\\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 10:07:31 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build 10:07:31 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:07:31 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:07:31 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Roaming', 10:07:31 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:07:31 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:07:31 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:07:31 INFO - 'COMPUTERNAME': 'T-W864-IX-066', 10:07:31 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:07:31 INFO - 'DCLOCATION': 'SCL3', 10:07:31 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:07:31 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:07:31 INFO - 'HOMEDRIVE': 'C:', 10:07:31 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 10:07:31 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:07:31 INFO - 'KTS_VERSION': '1.19c', 10:07:31 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 10:07:31 INFO - 'LOGONSERVER': '\\\\T-W864-IX-066', 10:07:31 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:07:31 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:31 INFO - 'MOZ_NO_REMOTE': '1', 10:07:31 INFO - 'NO_EM_RESTART': '1', 10:07:31 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:07:31 INFO - 'OS': 'Windows_NT', 10:07:31 INFO - 'OURDRIVE': 'C:', 10:07: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;', 10:07:31 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:07:31 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:07:31 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:07:31 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:07:31 INFO - 'PROCESSOR_LEVEL': '6', 10:07:31 INFO - 'PROCESSOR_REVISION': '1e05', 10:07:31 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:07:31 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:07:31 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:07:31 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:07:31 INFO - 'PROMPT': '$P$G', 10:07:31 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:07:31 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:07:31 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:07:31 INFO - 'PWD': 'C:\\slave\\test', 10:07:31 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:07:31 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:07:31 INFO - 'SYSTEMDRIVE': 'C:', 10:07:31 INFO - 'SYSTEMROOT': 'C:\\windows', 10:07:31 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:31 INFO - 'TEST1': 'testie', 10:07:31 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:31 INFO - 'USERDOMAIN': 'T-W864-IX-066', 10:07:31 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 10:07:31 INFO - 'USERNAME': 'cltbld', 10:07:31 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-066', 10:07:31 INFO - 'WINDIR': 'C:\\windows', 10:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:31 INFO - Downloading/unpacking jsonschema==2.5.1 10:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:32 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:32 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 10:07:32 INFO - warning: no files found matching '*.txt' 10:07:32 INFO - no previously-included directories found matching 'build' 10:07:32 INFO - no previously-included directories found matching 'dist' 10:07:32 INFO - no previously-included directories found matching '.git*' 10:07:32 INFO - Installing collected packages: jsonschema, functools32 10:07:32 INFO - Running setup.py install for functools32 10:07:33 INFO - warning: no files found matching '*.txt' 10:07:33 INFO - no previously-included directories found matching 'build' 10:07:33 INFO - no previously-included directories found matching 'dist' 10:07:33 INFO - no previously-included directories found matching '.git*' 10:07:33 INFO - Successfully installed jsonschema functools32 10:07:33 INFO - Cleaning up... 10:07:33 INFO - Return code: 0 10:07:33 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 10:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:33 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0245C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024DDE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028E4AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024B8E90>, '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 0x01EDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02924520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-066', 'USERDOMAIN': 'T-W864-IX-066', '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-066', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-066', '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-066\\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 10:07:33 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 10:07:33 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:07:33 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:07:33 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Roaming', 10:07:33 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:07:33 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:07:33 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:07:33 INFO - 'COMPUTERNAME': 'T-W864-IX-066', 10:07:33 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:07:33 INFO - 'DCLOCATION': 'SCL3', 10:07:33 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:07:33 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:07:33 INFO - 'HOMEDRIVE': 'C:', 10:07:33 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 10:07:33 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:07:33 INFO - 'KTS_VERSION': '1.19c', 10:07:33 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 10:07:33 INFO - 'LOGONSERVER': '\\\\T-W864-IX-066', 10:07:33 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:07:33 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:33 INFO - 'MOZ_NO_REMOTE': '1', 10:07:33 INFO - 'NO_EM_RESTART': '1', 10:07:33 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:07:33 INFO - 'OS': 'Windows_NT', 10:07:33 INFO - 'OURDRIVE': 'C:', 10:07:33 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 10:07:33 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:07:33 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:07:33 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:07:33 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:07:33 INFO - 'PROCESSOR_LEVEL': '6', 10:07:33 INFO - 'PROCESSOR_REVISION': '1e05', 10:07:33 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:07:33 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:07:33 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:07:33 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:07:33 INFO - 'PROMPT': '$P$G', 10:07:33 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:07:33 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:07:33 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:07:33 INFO - 'PWD': 'C:\\slave\\test', 10:07:33 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:07:33 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:07:33 INFO - 'SYSTEMDRIVE': 'C:', 10:07:33 INFO - 'SYSTEMROOT': 'C:\\windows', 10:07:33 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:33 INFO - 'TEST1': 'testie', 10:07:33 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:33 INFO - 'USERDOMAIN': 'T-W864-IX-066', 10:07:33 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 10:07:33 INFO - 'USERNAME': 'cltbld', 10:07:33 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-066', 10:07:33 INFO - 'WINDIR': 'C:\\windows', 10:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 10:07:33 INFO - Cleaning up... 10:07:34 INFO - Return code: 0 10:07:34 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 10:07:34 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')]} 10:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:34 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')]} 10:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:34 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 0x0245C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024DDE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028E4AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024B8E90>, '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 0x01EDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02924520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-066', 'USERDOMAIN': 'T-W864-IX-066', '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-066', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-066', '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-066\\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 10:07:34 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 10:07:34 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 10:07:34 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:07:34 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Roaming', 10:07:34 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:07:34 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:07:34 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:07:34 INFO - 'COMPUTERNAME': 'T-W864-IX-066', 10:07:34 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:07:34 INFO - 'DCLOCATION': 'SCL3', 10:07:34 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:07:34 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:07:34 INFO - 'HOMEDRIVE': 'C:', 10:07:34 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 10:07:34 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:07:34 INFO - 'KTS_VERSION': '1.19c', 10:07:34 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 10:07:34 INFO - 'LOGONSERVER': '\\\\T-W864-IX-066', 10:07:34 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:07:34 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:34 INFO - 'MOZ_NO_REMOTE': '1', 10:07:34 INFO - 'NO_EM_RESTART': '1', 10:07:34 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:07:34 INFO - 'OS': 'Windows_NT', 10:07:34 INFO - 'OURDRIVE': 'C:', 10:07:34 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;', 10:07:34 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:07:34 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:07:34 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:07:34 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:07:34 INFO - 'PROCESSOR_LEVEL': '6', 10:07:34 INFO - 'PROCESSOR_REVISION': '1e05', 10:07:34 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:07:34 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:07:34 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:07:34 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:07:34 INFO - 'PROMPT': '$P$G', 10:07:34 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:07:34 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:07:34 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:07:34 INFO - 'PWD': 'C:\\slave\\test', 10:07:34 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:07:34 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:07:34 INFO - 'SYSTEMDRIVE': 'C:', 10:07:34 INFO - 'SYSTEMROOT': 'C:\\windows', 10:07:34 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:34 INFO - 'TEST1': 'testie', 10:07:34 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:34 INFO - 'USERDOMAIN': 'T-W864-IX-066', 10:07:34 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 10:07:34 INFO - 'USERNAME': 'cltbld', 10:07:34 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-066', 10:07:34 INFO - 'WINDIR': 'C:\\windows', 10:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:34 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:35 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:35 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 10:07:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:35 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 10:07:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:36 INFO - Downloading docopt-0.6.1.tar.gz 10:07:36 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 10:07:36 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:36 INFO - Running setup.py install for blobuploader 10:07:36 INFO - Running setup.py install for requests 10:07:36 INFO - Running setup.py install for docopt 10:07:37 INFO - Successfully installed blobuploader requests docopt 10:07:37 INFO - Cleaning up... 10:07:38 INFO - Return code: 0 10:07:38 INFO - Installing None into virtualenv C:\slave\test\build/venv 10:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:38 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 0x0245C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024DDE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028E4AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024B8E90>, '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 0x01EDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02924520>, '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-066', 'USERDOMAIN': 'T-W864-IX-066', '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-066', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-066', '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-066\\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 10:07:38 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 10:07:38 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 10:07:38 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:07:38 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Roaming', 10:07:38 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:07:38 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:07:38 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:07:38 INFO - 'COMPUTERNAME': 'T-W864-IX-066', 10:07:38 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:07:38 INFO - 'DCLOCATION': 'SCL3', 10:07:38 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:07:38 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:07:38 INFO - 'HOMEDRIVE': 'C:', 10:07:38 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 10:07:38 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:07:38 INFO - 'KTS_VERSION': '1.19c', 10:07:38 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 10:07:38 INFO - 'LOGONSERVER': '\\\\T-W864-IX-066', 10:07:38 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:07:38 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:38 INFO - 'MOZ_NO_REMOTE': '1', 10:07:38 INFO - 'NO_EM_RESTART': '1', 10:07:38 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:07:38 INFO - 'OS': 'Windows_NT', 10:07:38 INFO - 'OURDRIVE': 'C:', 10:07:38 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;', 10:07:38 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:07:38 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:07:38 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:07:38 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:07:38 INFO - 'PROCESSOR_LEVEL': '6', 10:07:38 INFO - 'PROCESSOR_REVISION': '1e05', 10:07:38 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:07:38 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:07:38 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:07:38 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:07:38 INFO - 'PROMPT': '$P$G', 10:07:38 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:07:38 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:07:38 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:07:38 INFO - 'PWD': 'C:\\slave\\test', 10:07:38 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:07:38 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:07:38 INFO - 'SYSTEMDRIVE': 'C:', 10:07:38 INFO - 'SYSTEMROOT': 'C:\\windows', 10:07:38 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:38 INFO - 'TEST1': 'testie', 10:07:38 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:38 INFO - 'USERDOMAIN': 'T-W864-IX-066', 10:07:38 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 10:07:38 INFO - 'USERNAME': 'cltbld', 10:07:38 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-066', 10:07:38 INFO - 'WINDIR': 'C:\\windows', 10:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 10:07:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lakdk7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 10:07:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 10:07:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nkewvt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 10:07:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 10:07:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pc2lk1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 10:07:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 10:07:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_jw5bi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 10:07:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 10:07:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7i9fdp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 10:07:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 10:07:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mbzs8o-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 10:07:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 10:07:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0tx0z1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 10:07:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 10:07:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ankyc3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 10:07:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 10:07:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_kefii-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 10:07:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 10:07:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gkn9so-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 10:07:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 10:07:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vxvifw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 10:07:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 10:07:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-avgs5c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 10:07:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 10:07:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-x7ihoj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 10:07:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 10:07:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-frsrkv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 10:07:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 10:07:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pnv0ni-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 10:07:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 10:07:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vi3izo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 10:07:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 10:07:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qpgmid-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 10:07:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:40 INFO - Running setup.py install for manifestparser 10:07:40 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 10:07:40 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 10:07:41 INFO - Running setup.py install for mozcrash 10:07:41 INFO - Running setup.py install for mozdebug 10:07:42 INFO - Running setup.py install for mozdevice 10:07:42 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 10:07:42 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 10:07:42 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 10:07:42 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 10:07:43 INFO - Running setup.py install for mozfile 10:07:43 INFO - Running setup.py install for mozhttpd 10:07:43 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 10:07:43 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 10:07:44 INFO - Running setup.py install for mozinfo 10:07:44 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 10:07:44 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 10:07:44 INFO - Running setup.py install for mozInstall 10:07:44 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 10:07:44 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 10:07:44 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 10:07:44 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 10:07:44 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 10:07:44 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 10:07:44 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 10:07:44 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 10:07:44 INFO - Running setup.py install for mozleak 10:07:45 INFO - Running setup.py install for mozlog 10:07:45 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 10:07:45 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 10:07:46 INFO - Running setup.py install for moznetwork 10:07:46 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 10:07:46 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 10:07:46 INFO - Running setup.py install for mozprocess 10:07:46 INFO - Running setup.py install for mozprofile 10:07:47 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 10:07:47 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 10:07:47 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 10:07:47 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 10:07:47 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 10:07:47 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 10:07:47 INFO - Running setup.py install for mozrunner 10:07:47 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 10:07:47 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 10:07:48 INFO - Running setup.py install for mozscreenshot 10:07:48 INFO - Running setup.py install for moztest 10:07:48 INFO - Running setup.py install for mozversion 10:07:49 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 10:07:49 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 10:07:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:07:49 INFO - Cleaning up... 10:07:49 INFO - Return code: 0 10:07:49 INFO - Installing None into virtualenv C:\slave\test\build/venv 10:07:49 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')]} 10:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:49 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')]} 10:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:49 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 0x0245C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024DDE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028E4AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024B8E90>, '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 0x01EDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02924520>, '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-066', 'USERDOMAIN': 'T-W864-IX-066', '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-066', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-066', '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-066\\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 10:07:49 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 10:07:49 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 10:07:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:07:49 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Roaming', 10:07:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:07:49 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:07:49 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:07:49 INFO - 'COMPUTERNAME': 'T-W864-IX-066', 10:07:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:07:49 INFO - 'DCLOCATION': 'SCL3', 10:07:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:07:49 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:07:49 INFO - 'HOMEDRIVE': 'C:', 10:07:49 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 10:07:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:07:49 INFO - 'KTS_VERSION': '1.19c', 10:07:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 10:07:49 INFO - 'LOGONSERVER': '\\\\T-W864-IX-066', 10:07:49 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:07:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:49 INFO - 'MOZ_NO_REMOTE': '1', 10:07:49 INFO - 'NO_EM_RESTART': '1', 10:07:49 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:07:49 INFO - 'OS': 'Windows_NT', 10:07:49 INFO - 'OURDRIVE': 'C:', 10:07:49 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;', 10:07:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:07:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:07:49 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:07:49 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:07:49 INFO - 'PROCESSOR_LEVEL': '6', 10:07:49 INFO - 'PROCESSOR_REVISION': '1e05', 10:07:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:07:49 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:07:49 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:07:49 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:07:49 INFO - 'PROMPT': '$P$G', 10:07:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:07:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:07:49 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:07:49 INFO - 'PWD': 'C:\\slave\\test', 10:07:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:07:49 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:07:49 INFO - 'SYSTEMDRIVE': 'C:', 10:07:49 INFO - 'SYSTEMROOT': 'C:\\windows', 10:07:49 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:49 INFO - 'TEST1': 'testie', 10:07:49 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:49 INFO - 'USERDOMAIN': 'T-W864-IX-066', 10:07:49 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 10:07:49 INFO - 'USERNAME': 'cltbld', 10:07:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-066', 10:07:49 INFO - 'WINDIR': 'C:\\windows', 10:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 10:07:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-x1tqxq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 10:07:49 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)) 10:07:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 10:07:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ybfwhs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 10:07:49 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)) 10:07:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 10:07:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-h8ft6i-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 10:07:49 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)) 10:07:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 10:07:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wckbok-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 10:07:50 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)) 10:07:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 10:07:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-blxwxx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 10:07:50 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)) 10:07:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 10:07:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nttupi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 10:07:50 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)) 10:07:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 10:07:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o0tdk7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 10:07:50 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)) 10:07:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 10:07:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-12cjcl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 10:07:50 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)) 10:07:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 10:07:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-egpoov-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 10:07:50 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)) 10:07:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 10:07:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t3ltnf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 10:07:50 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)) 10:07:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 10:07:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eqcwhw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 10:07:50 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)) 10:07:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 10:07:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wztywu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12)) 10:07:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 10:07:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qmnjzo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 10:07:51 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)) 10:07:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 10:07:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fwuamy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 10:07:51 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)) 10:07:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 10:07:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tmgnaq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 10:07:51 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)) 10:07:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 10:07:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ge8axe-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 10:07:51 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)) 10:07:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 10:07:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vh0n83-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 10:07:51 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)) 10:07:51 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)) 10:07:51 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)) 10:07:51 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)) 10:07:51 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)) 10:07:51 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)) 10:07:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 10:07:51 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 10:07:51 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 10:07:52 INFO - Downloading blessings-1.6.tar.gz 10:07:52 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 10:07:53 INFO - Installing collected packages: blessings 10:07:53 INFO - Running setup.py install for blessings 10:07:53 INFO - Successfully installed blessings 10:07:53 INFO - Cleaning up... 10:07:56 INFO - Return code: 0 10:07:56 INFO - Done creating virtualenv C:\slave\test\build/venv. 10:07:56 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 10:07:56 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 10:07:56 INFO - Reading from file tmpfile_stdout 10:07:56 INFO - Using _rmtree_windows ... 10:07:56 INFO - Using _rmtree_windows ... 10:07:56 INFO - Current package versions: 10:07:56 INFO - blessings == 1.6 10:07:56 INFO - blobuploader == 1.2.4 10:07:56 INFO - docopt == 0.6.1 10:07:56 INFO - functools32 == 3.2.3-2 10:07:56 INFO - jsonschema == 2.5.1 10:07:56 INFO - manifestparser == 1.1 10:07:56 INFO - mozInstall == 1.12 10:07:56 INFO - mozcrash == 0.17 10:07:56 INFO - mozdebug == 0.1 10:07:56 INFO - mozdevice == 0.48 10:07:56 INFO - mozfile == 1.2 10:07:56 INFO - mozhttpd == 0.7 10:07:56 INFO - mozinfo == 0.9 10:07:56 INFO - mozleak == 0.1 10:07:56 INFO - mozlog == 3.4 10:07:56 INFO - moznetwork == 0.27 10:07:56 INFO - mozprocess == 0.23 10:07:56 INFO - mozprofile == 0.28 10:07:56 INFO - mozrunner == 6.12 10:07:56 INFO - mozscreenshot == 0.1 10:07:56 INFO - mozsystemmonitor == 0.3 10:07:56 INFO - moztest == 0.7 10:07:56 INFO - mozversion == 1.4 10:07:56 INFO - psutil == 3.1.1 10:07:56 INFO - requests == 1.2.3 10:07:56 INFO - Installing None into virtualenv C:\slave\test\build/venv 10:07:56 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')]} 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:56 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')]} 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:56 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 0x0245C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024DDE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028E4AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024B8E90>, '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 0x01EDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02924520>, '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-066', 'USERDOMAIN': 'T-W864-IX-066', '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-066', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-066', '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-066\\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 10:07:56 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 10:07:56 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 10:07:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:07:56 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Roaming', 10:07:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:07:56 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:07:56 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:07:56 INFO - 'COMPUTERNAME': 'T-W864-IX-066', 10:07:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:07:56 INFO - 'DCLOCATION': 'SCL3', 10:07:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:07:56 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:07:56 INFO - 'HOMEDRIVE': 'C:', 10:07:56 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 10:07:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:07:56 INFO - 'KTS_VERSION': '1.19c', 10:07:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 10:07:56 INFO - 'LOGONSERVER': '\\\\T-W864-IX-066', 10:07:56 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:07:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:56 INFO - 'MOZ_NO_REMOTE': '1', 10:07:56 INFO - 'NO_EM_RESTART': '1', 10:07:56 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:07:56 INFO - 'OS': 'Windows_NT', 10:07:56 INFO - 'OURDRIVE': 'C:', 10:07:56 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;', 10:07:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:07:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:07:56 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:07:56 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:07:56 INFO - 'PROCESSOR_LEVEL': '6', 10:07:56 INFO - 'PROCESSOR_REVISION': '1e05', 10:07:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:07:56 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:07:56 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:07:56 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:07:56 INFO - 'PROMPT': '$P$G', 10:07:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:07:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:07:56 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:07:56 INFO - 'PWD': 'C:\\slave\\test', 10:07:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:07:56 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:07:56 INFO - 'SYSTEMDRIVE': 'C:', 10:07:56 INFO - 'SYSTEMROOT': 'C:\\windows', 10:07:56 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:56 INFO - 'TEST1': 'testie', 10:07:56 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:56 INFO - 'USERDOMAIN': 'T-W864-IX-066', 10:07:56 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 10:07:56 INFO - 'USERNAME': 'cltbld', 10:07:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-066', 10:07:56 INFO - 'WINDIR': 'C:\\windows', 10:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 INFO - Cleaning up... 10:07:56 INFO - Return code: 0 10:07:56 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 10:07:56 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')]} 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:56 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')]} 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:56 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 0x0245C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024DDE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028E4AE8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024B8E90>, '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 0x01EDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02924520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-066', 'USERDOMAIN': 'T-W864-IX-066', '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-066', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-066', '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-066\\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 10:07:56 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 10:07:56 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 10:07:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:07:56 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Roaming', 10:07:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:07:56 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:07:56 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:07:56 INFO - 'COMPUTERNAME': 'T-W864-IX-066', 10:07:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:07:56 INFO - 'DCLOCATION': 'SCL3', 10:07:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:07:56 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:07:56 INFO - 'HOMEDRIVE': 'C:', 10:07:56 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 10:07:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:07:56 INFO - 'KTS_VERSION': '1.19c', 10:07:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 10:07:56 INFO - 'LOGONSERVER': '\\\\T-W864-IX-066', 10:07:56 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:07:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:56 INFO - 'MOZ_NO_REMOTE': '1', 10:07:56 INFO - 'NO_EM_RESTART': '1', 10:07:56 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:07:56 INFO - 'OS': 'Windows_NT', 10:07:56 INFO - 'OURDRIVE': 'C:', 10:07:56 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;', 10:07:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:07:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:07:56 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:07:56 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:07:56 INFO - 'PROCESSOR_LEVEL': '6', 10:07:56 INFO - 'PROCESSOR_REVISION': '1e05', 10:07:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:07:56 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:07:56 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:07:56 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:07:56 INFO - 'PROMPT': '$P$G', 10:07:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:07:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:07:56 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:07:56 INFO - 'PWD': 'C:\\slave\\test', 10:07:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:07:56 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:07:56 INFO - 'SYSTEMDRIVE': 'C:', 10:07:56 INFO - 'SYSTEMROOT': 'C:\\windows', 10:07:56 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:56 INFO - 'TEST1': 'testie', 10:07:56 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:07:56 INFO - 'USERDOMAIN': 'T-W864-IX-066', 10:07:56 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 10:07:56 INFO - 'USERNAME': 'cltbld', 10:07:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-066', 10:07:56 INFO - 'WINDIR': 'C:\\windows', 10:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 10:07:57 INFO - Cleaning up... 10:07:57 INFO - Return code: 0 10:07:57 INFO - Running post-action listener: _resource_record_post_action 10:07:57 INFO - Running post-action listener: _start_resource_monitoring 10:07:57 INFO - Starting resource monitoring. 10:07:57 INFO - [mozharness: 2016-10-14 17:07:57.145000Z] Finished create-virtualenv step (success) 10:07:57 INFO - [mozharness: 2016-10-14 17:07:57.145000Z] Running install step. 10:07:57 INFO - Running pre-action listener: _resource_record_pre_action 10:07:57 INFO - Running main action method: install 10:07:57 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 10:07:57 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 10:07:57 INFO - Reading from file tmpfile_stdout 10:07:57 INFO - Using _rmtree_windows ... 10:07:57 INFO - Using _rmtree_windows ... 10:07:57 INFO - Detecting whether we're running mozinstall >=1.0... 10:07:57 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 10:07:57 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 10:07:57 INFO - Reading from file tmpfile_stdout 10:07:57 INFO - Output received: 10:07:57 INFO - Usage: mozinstall-script.py [options] installer 10:07:57 INFO - Options: 10:07:57 INFO - -h, --help show this help message and exit 10:07:57 INFO - -d DEST, --destination=DEST 10:07:57 INFO - Directory to install application into. [default: 10:07:57 INFO - "C:\slave\test"] 10:07:57 INFO - --app=APP Application being installed. [default: firefox] 10:07:57 INFO - Using _rmtree_windows ... 10:07:57 INFO - Using _rmtree_windows ... 10:07:57 INFO - mkdir: C:\slave\test\build\application 10:07:57 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'] 10:07:57 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 10:08:00 INFO - Reading from file tmpfile_stdout 10:08:00 INFO - Output received: 10:08:00 INFO - C:\slave\test\build\application\firefox\firefox.exe 10:08:00 INFO - Using _rmtree_windows ... 10:08:00 INFO - Using _rmtree_windows ... 10:08:00 INFO - Running post-action listener: _resource_record_post_action 10:08:00 INFO - [mozharness: 2016-10-14 17:08:00.060000Z] Finished install step (success) 10:08:00 INFO - [mozharness: 2016-10-14 17:08:00.060000Z] Running run-tests step. 10:08:00 INFO - Running pre-action listener: _resource_record_pre_action 10:08:00 INFO - Running main action method: run_tests 10:08:00 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 10:08:00 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 10:08:00 INFO - Python 2.7.3 10:08:00 INFO - Return code: 0 10:08:00 INFO - grabbing minidump binary from tooltool 10:08:00 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')]} 10:08:00 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 0x024B8E90>, '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 0x01EDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02924520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 10:08:00 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 10:08:00 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 10:08:00 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 10:08:00 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 10:08:01 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpdcwgd4 10:08:01 INFO - INFO - File integrity verified, renaming tmpdcwgd4 to win32-minidump_stackwalk.exe 10:08:01 INFO - Return code: 0 10:08:01 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 10:08:01 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 10:08:01 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 10:08:01 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 10:08:01 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 10:08:01 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-066', '--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 10:08:01 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Firefox --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-066 --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 10:08:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:08:01 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Roaming', 10:08:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:08:01 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:08:01 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:08:01 INFO - 'COMPUTERNAME': 'T-W864-IX-066', 10:08:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:08:01 INFO - 'DCLOCATION': 'SCL3', 10:08:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:08:01 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:08:01 INFO - 'HOMEDRIVE': 'C:', 10:08:01 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-066', 10:08:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:08:01 INFO - 'KTS_VERSION': '1.19c', 10:08:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-066\\AppData\\Local', 10:08:01 INFO - 'LOGONSERVER': '\\\\T-W864-IX-066', 10:08:01 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 10:08:01 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 10:08:01 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:08:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:01 INFO - 'MOZ_NO_REMOTE': '1', 10:08:01 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 10:08:01 INFO - 'NO_EM_RESTART': '1', 10:08:01 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:08:01 INFO - 'OS': 'Windows_NT', 10:08:01 INFO - 'OURDRIVE': 'C:', 10:08:01 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 10:08:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:08:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:08:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:08:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:08:02 INFO - 'PROCESSOR_LEVEL': '6', 10:08:02 INFO - 'PROCESSOR_REVISION': '1e05', 10:08:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:08:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:08:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:08:02 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:08:02 INFO - 'PROMPT': '$P$G', 10:08:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:08:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:08:02 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:08:02 INFO - 'PWD': 'C:\\slave\\test', 10:08:02 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 10:08:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:08:02 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:08:02 INFO - 'SYSTEMDRIVE': 'C:', 10:08:02 INFO - 'SYSTEMROOT': 'C:\\windows', 10:08:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:08:02 INFO - 'TEST1': 'testie', 10:08:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:08:02 INFO - 'USERDOMAIN': 'T-W864-IX-066', 10:08:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-066', 10:08:02 INFO - 'USERNAME': 'cltbld', 10:08:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-066', 10:08:02 INFO - 'WINDIR': 'C:\\windows', 10:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:08:02 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-066', '--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 10:08:02 INFO - mozversion application_buildid: 20161014060324 10:08:02 INFO - mozversion application_changeset: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 10:08:02 INFO - mozversion application_display_name: Nightly 10:08:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:02 INFO - mozversion application_name: Firefox 10:08:02 INFO - mozversion application_remotingname: firefox 10:08:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:08:02 INFO - mozversion application_vendor: Mozilla 10:08:02 INFO - mozversion application_version: 52.0a1 10:08:02 INFO - mozversion platform_buildid: 20161014060324 10:08:02 INFO - mozversion platform_changeset: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 10:08:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:08:02 INFO - mozversion platform_version: 52.0a1 10:08:02 INFO - using testdate: 1476464882 10:08:02 INFO - actual date: 1476464882 10:08:02 INFO - starting webserver on 'localhost:49274' 10:08:02 INFO - SUITE-START | Running 2 tests 10:08:02 INFO - TEST-START | dromaeo_css 10:08:02 INFO - operating with platform_type : w8_ 10:08:02 INFO - Initialising browser for dromaeo_css test... 10:08:03 INFO - TEST-INFO | started process 720 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpriwsxk\profile http://localhost:49274/getInfo.html) 10:08:14 INFO - PROCESS | 720 | __metrics Screen width/height:1600/1200 10:08:14 INFO - PROCESS | 720 | colorDepth:24 10:08:14 INFO - PROCESS | 720 | Browser inner width/height: 1010/674 10:08:14 INFO - PROCESS | 720 | __metrics 10:08:16 INFO - PROCESS | 720 | 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" 10:08:16 INFO - PROCESS | 720 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:08:17 INFO - TEST-INFO | 720: exit 0 10:08:17 INFO - Browser initialized. 10:08:17 INFO - Running cycle 1/1 for dromaeo_css test... 10:08:17 INFO - TEST-INFO | started process 3272 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpriwsxk\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:18 INFO - PROCESS | 3272 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 10:08:28 INFO - PROCESS | 3272 | RSS: Main: 158056448 10:08:28 INFO - PROCESS | 3272 | 10:09:19 INFO - PROCESS | 3272 | 1476464959888 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] 10:11:32 INFO - PROCESS | 3272 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 10:11:33 INFO - PROCESS | 3272 | RSS: Main: 243060736 10:11:33 INFO - PROCESS | 3272 | 10:14:36 INFO - PROCESS | 3272 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 10:14:37 INFO - PROCESS | 3272 | RSS: Main: 226742272 10:14:37 INFO - PROCESS | 3272 | 10:17:39 INFO - PROCESS | 3272 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 10:17:39 INFO - PROCESS | 3272 | RSS: Main: 200929280 10:17:39 INFO - PROCESS | 3272 | 10:20:42 INFO - PROCESS | 3272 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 10:20:42 INFO - PROCESS | 3272 | RSS: Main: 168165376 10:20:42 INFO - PROCESS | 3272 | 10:23:45 INFO - PROCESS | 3272 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 10:23:46 INFO - PROCESS | 3272 | RSS: Main: 164864000 10:23:46 INFO - PROCESS | 3272 | 10:26:49 INFO - PROCESS | 3272 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 10:26:49 INFO - PROCESS | 3272 | RSS: Main: 203218944 10:26:49 INFO - PROCESS | 3272 | 10:26:49 INFO - PROCESS | 3272 | __start_tp_report 10:26:49 INFO - PROCESS | 3272 | _x_x_mozilla_page_load 10:26:49 INFO - PROCESS | 3272 | _x_x_mozilla_page_load_details 10:26:49 INFO - PROCESS | 3272 | |i|pagename|runs| 10:26:49 INFO - PROCESS | 3272 | |0;dojo.html;2856.971430285697;2879.928001799956;2882.827030378177;2913.1260621813462;2925.3125515503853;5141.511556402141;5259.289995850559;5277.577793776498;5298.788048478056;5330.333708286465;5171.482851714826;5226.007058658862;5247.685138891669;5257.763400646971;5272.340957380327;4686.367340409035;4691.225947718623;4699.90600187996;4718.598919091882;4753.595944344717;4743.430788305391;4769.022350418156;4770.522947705236;4772.331873537708;4772.618190544748;4692.343071969927;4721.315409265654;4748;4750.501197374278;4766.52334766524;4749.952500474986;4750.049990002013;4780.235162374003;4792.496787837262;4846.1761500544635;4442.355858400514;4591.678582499227;4695.460022097434;4705.741184234866;4796.784144713496;5170.896582068338;5198.688078715251;5216.035033518811;5230.110881150175;5266.60500462463;5510.228568000483;5550.639208451478;5577.107662773978;5608.831735047915;5616.129499927518;5564.4713752193475;5656.095024796013;5662.065759149736;5666.706245547379;5715.628484148517;5147.7683504242395;5180.9740951295;5200.8439746808035;5217.895642087137;5219.243209734567;5730.713464326767;5765.07758758605;5771.163181338682;5797.391273916262;5801.100829371454;5496.587755918322;5530.281063461724;5531.834044978657;5541.196526503715;5542.39033706292;5572.693501857356;5618.747156377973;5621.156826476062;5686.601937864392;5687.289088863892;5519.917201241985;5534.833954981357;5575.386707462176;5630.71846407678;5655.575831812548;5580.972095139579;5589.273394458775;5590.329160500684;5632.352279487911;5653.152027195953;3699.8150092495266;3709.2025214578994;3710.05393624624;3715.071232191952;3754.8310326035394;3295.489199174132;3335.69978701918;3336.132605522582;3343.4483310253536;3383.9492407613907;5220.660657057279;5225.686458812484;5226.111561034557;5226.843194704165;5229.372475302912;5601.215829783833;5603.831885043455;5606.355269144019;5609.1305847593685;5648.8870222595315;5178.145605974972;5188.143956247252;5219.556337711337;5226.137687281632;5237.5548078413;4585.72485650862;4629.328747331618;4630.699004564693;4631.328457373662;4634.976825115853;5714;5794.449527294984;5799.18811366409;5804.564657650693;5811.4479124483105;5653.349864765604;5657.038303488499;5671.17767923657;5713.085906254979;5719.370869204467;5823.5923485355615;5828.795992140254;5831.154482599914;5847.5906686533235;5851.473367396955;5460.290162278879;5513.9448605513435;5594.804181853616;5635.675616230101;5639.971800140973;5593.105103183634;5665.830025099253;5672.943270567242;5692.48767610917;5710.486056254957;5511.476409741068;5513.558915286848;5523.392426833126;5525.033119204043;5528.585356098389;5522.06124958766;5527.198556209408;5529.22590837275;5531.7234138293725;5574.358948720949;5230.372355317234;5312.309399778004;5400.270963419888;5423;5423.322084739408;5526.364468086222;5554.1391084381985;5559.054960656779;5563.77744890216;5612.915806262991;5472.179173123904;5474.09677403224;5488.670679759227;5491.203775452617;5496 10:26:49 INFO - PROCESS | 3272 | |1;ext.html;541.6371031408955;553.6180035775316;553.6346011632323;555.7443575955058;564.2833601326315;29279.26801829953;30431.23921901951;32340.353192936127;36840.631593684055;37919;38365.04087397816;38791.22417551647;39196;39220.411693824615;39241;8294.70968516102;8446.78883027923;8451.281641060517;8459.577021148918;8460.280876125536;7882.566458844762;8067.112617612087;8247.340212782992;8306.54314012729;9680.177184939288;9981.351212171221;10246.846297305547;10296.124829389473;10316.690499284996;10319.58721651133;9959.75100622483;10012.148967337786;10067.949660251725;10083.596656133746;10087.193024558017;7937.1665975072365;8193.344532437392;9586.808263834753;9902.257330700226;9905.207583393383;36556.26887462236;36609.45085823715;36770.44844327337;36858.63141368579;36884.262314753825;2822.082823082486;2828.391895742405;2904.985475072632;3338.2488939988552;3556.822158892045;28429.57355639667;28665.426691466262;28691.139265822057;28702.425951481062;28722.112762950954;3790.431435284702;3801.961980380216;3838.8848334550007;3840.36633955397;3921.745086569364;263023;281871;284108;284424;284848;42088.57911420908;43499.042543085634;45170.77414612972;45490.54509454929;46213.7689311558;49040;49169;49370;49370.753146234754;49429.75285123551;12944.482220711066;13037.934810325887;13073.869261307265;13088.345582720825;13091.607251782461;9779.559919803483;9859.654912078044;9895.30732848708;9898.356606820678;9912.752181195383;12460.314682692358;12477.875221247852;13033.804492932613;13388.93305533466;13603.455861765617;4959.156943319645;5042.218456139304;5105.617078719111;5175.741212939338;5274.525292723597;709.3651182191909;797.1339005821718;925.7315378540148;933.9579718912665;934.4907025671025;25186.74813251844;25711.61432578513;26385.208443746717;26506;26660.60009099865;883.5228976352826;895.5969813583783;914.346242436661;924.8335299646128;980.926430517714;13571.59285221445;13835.51575694866;13933.024688271926;14029.438822447191;14100;409835;413669;413855;414746;418085;44795.77602111969;45032;45071.54928450739;45113.09773804506;45126;994.0357852882693;1004.1866088468364;1010.4240582867695;1036.9481525923673;1090.5092708281304;25116.372090697878;27042.594361084204;27434;27434.725652744015;27449.588256175775;39105;39376.606233937295;39520.604793951694;39547;39567.604323957545;315225;331068;331699;332721;333205;23868.880655597306;24307.513849722553;24378.146764863144;24643.87678061598;24949.251522454357;39704.2059158821;39770.80114599408;40349.79825100856;40388.98055097175;40828.59171408367;34157.829210853786;34202.48696269608;34487;34687.306253874274;34967.475487867196;34282.828585856914;34568.82715586406;34680;34688.65311346854;34835.30329393347;32700.258462523278;32886.671133288364;33272.66727332696;33333.83333083319;33377.83311083429;30292.24269393283;31490.685093148775;31652.683473164972;31802.522962155123;31817.840910796225;23520.882395587912;23758.881205594553;23807.761922380556;24044.87977560101;24215.63676544818 10:26:49 INFO - PROCESS | 3272 | |2;jquery.html;325.1675710181936;337.78550620356066;341.8307937570902;342.825159168824;359.64035964035963;13260.138091024077;14162.858371416283;15936.601584960381;16162.595935101628;16392.50822475325;13083.542076027341;13268.137571057874;13291.867081329208;13961.371738271777;14918.104913705185;5098.4901509848905;5294.629375943686;5308.097623404031;5309.867253318659;5313.574914006889;4907.362042934414;4983.800647974077;5231.895362092756;5274.894502109955;5302.681839089667;5220.608454365919;5239.292695486118;5248.71132087735;5249.186376111708;5250.343707036621;5044.82343117991;5213.139831927728;5233.973830130844;5243.265942767977;5247.212918062283;4663.906721865577;4678.251479763221;4678.508756580578;4679.251319788851;4680.906381872377;19371.23306745173;19589.31437399684;19645.9017704912;19927.50181245466;20133.295334663362;1844.4097888675628;1850.3986204483463;1897.383350411122;1908.7804902436258;1976.199639146148;8668.956655216747;12360.567380141742;13093.934530327382;13596.252206128658;13610.115342502804;1800.6578750037452;1855.6845336292863;1879.257693211174;1879.9906000470046;1890.7069404242363;67254;68064.9999999995;69145;69584.6520767398;73404.26595734028;9640.180584650383;9717.12545870861;9820.263480239011;9847.16299114569;9866.80266394668;13114.475420983053;13117.934410327887;13135.540256090992;13137.73724525504;13156.60530184096;6748.426383757337;6789.1852977643;6879.346462086094;6885.862282754317;6914.135733033371;6341.968290158519;6373.139626150503;6466.256380516207;6477.611343319416;6494.9675251624385;4058.5332686740812;4141.958580414218;4149.25313443583;4177.624013838769;4222.155568886235;1567.4670611991978;1618.7248167811501;1679.1436367452686;1681.9327226910787;1697.8556822669964;752.4243953375671;775.2363921537282;818.7134502924048;845.5011543189547;909.8771665825161;16368.181590920645;16791.496255112364;17056.744148837777;17117.22972466242;17234.396796112076;776.7087342246657;784.1491981200347;790.1979490816825;807.7495976247382;808.3613944983515;8981.241269207638;9275.860862087075;9344.813103737888;9370.765730856783;9429.717108486619;386906;394417;395645;396049;401442;78009;78810;79159.60420197863;80572.59713701511;81391.18608813954;857.9785505362416;878.4948654523547;879.098923603299;879.2702057292432;879.7360791762445;14528.782068269196;14688.632784180054;14711.33798979027;14858.925705371405;15104.697906042038;35603.46594801132;35612.821935890155;36003.45994810027;36179.743823054996;37012;48681;48766.268505971726;49518.50481495283;49557.25664114969;49580.25629615631;6616.735330586916;7049;7145.714171433292;7388.002619646494;7709.614519274126;11487.655370338904;11931.343776092051;12197;12317.137800353888;12520.436580354088;10119.696409107739;10297.279190456597;10505.054545090978;10571.577136914744;10792.082672972885;10150.340227885164;10510.789784204426;10631.893681063091;10703.143748500257;10843.891561084289;7316.9634151828905;9315.34792564514;10340.27618066728;10849.186311026546;10882.12942964545;7453;7517.661705223388;7557.5465472071855;7792.2986931176465;7989.201079891965;7757.883631745642;10005.54975026111;10322;10336.793264134525;10396.116330112025 10:26:49 INFO - PROCESS | 3272 | |3;mootools.html;1109.9223054386187;1128.204615745899;1139.7093741096019;1215.750771091926;1423.878970287526;6946.340097690724;7446.702131914723;7714.074311082678;7741.8838717419285;7757.301842834151;7733.961330193355;7760.844783104335;7783.571903545303;7787.883181752264;7799.805004874881;2017.7982201779814;2041.3467690339098;2043.5095577061547;2044.2640649366217;2044.9897750511302;1946.776120746118;1952.6875699888021;1957.4714826996703;1977.6736838421716;1982.5043739065234;1934.980650193501;1951.4145756273133;1953.3591782902358;1955.559999000228;1958.0014192761723;1933.787283398825;1934.806519348068;1937.1960636335903;1938.6704260275646;1947.09460101053;1923.1922592511178;1928.8167624075832;1936.9225230990744;1984.6923726822365;1993.1429485321305;7649;7703.191164927658;7727.806804829925;7746.341560967325;7747.573883436408;4168.937465938014;4328.069465065026;4334.241507736165;4334.306510958231;4340.544242854487;2945.631796025497;3025.6823033581595;3059.8623061962267;3067.7699172561925;3082.321889184376;988.3970777825521;990.2028866762254;1005.215931573374;1006.9848952265722;1014.2849291249652;10693.518791654316;10698.358098514036;10702.35785852859;10733.892661073367;10746.946265268623;3680.815959202083;3980.402939559089;4104.692148088905;4108.77401742901;4135.855245066468;8401.075881653012;8466.703665371682;8480.363972702073;8490.066092729794;8495.575221238912;4353.1293741251875;4353.976815448367;4356.869293921188;4359.14996575671;4365.236083685342;3595.137167079882;3744.8689295874515;3863.55569109556;4065.390191471303;4067.471228740304;3324.1523411529906;3359.714424273915;3363.4786608075788;3395.5076513905346;3446.913827154291;985.5023213277392;989.5497548615363;990.4305024610877;991.5934466868549;999.6305062065018;638.8243233110932;772.3010675338827;781.6131015147424;782.1630854985111;786.5320134520066;4899.706017638953;4913.77887995034;4969.105560998983;5029.1953287473825;5117.078925793393;364.2369236449634;366.9669729724338;370.1098857248268;370.5608853508601;381.23942734245355;3329.6503867093606;3351.8771211643884;3371.9325613487595;3397.405454045582;3425.1950791563963;9353.345265831462;9694.709158725249;9722.854157187649;9725.124738773402;9745.463999480096;9669.17811985975;9674.854877176847;9686.806263874683;9705.417674939526;9713.757156071155;7256.2018178001435;7271.563706177646;7335.083114610674;7377.045083052995;7396.593187374746;4730.455997560324;4765.181661331008;4773.331733557236;4850.1269771441475;4910.656254062182;8863.822723545622;8920.24177944882;8972.19250267479;9015.819683606422;9035.412698174598;8111.432199745961;8520.3183745299;8773.078826723358;8866;9150.816983660423;6569.310222426577;6700.865982680221;6703.095082163845;6708.161479815023;6717.193936727428;7285.526440781332;7395.8151046224275;7471.215522370073;7509.6245187739305;7529.1717911028645;6688.130543029375;6729.226138994079;6780.321967803377;6795.694193761194;6887.621180834902;6372.681365931778;6534.738610455529;6612.5040621952585;6638.502112341497;6728.764493242713;6216.968915155395;6281.371862813682;6315;6349.269833969152;6355.936440635534;4109.0549173690815;4132.235536425771;4146.232946904832;4200.957990420179;4252.681048921281;4130.690198235205;4157.334826427757;4167.770772607536;4173.645240154621;4232.555581664004 10:26:49 INFO - PROCESS | 3272 | |4;prototype.html;287.3491541658144;288.8483546138277;292.19354581355464;292.4852260022361;296.73442269169107;5189.714565698885;5362.570994320455;5368.516833484986;5409.43200963899;5435;5277.419483856773;5293;5309.522143007129;5310.698878774696;5354.866128346794;3755.586885442599;3886.8833934981994;4007.537248904151;4015.3776164694373;4039.6364327210545;3717.3866312058476;3959.46547216125;3966.4645272888224;4014.578469260715;4019.919601607981;3933.331333673282;3996.840126394941;3997.8400863965408;4007.8597249096288;4029.8791036268813;3960.3663413853646;3978.4430179774854;3991.2217117662067;3995.20095980805;4033.1530378620523;3277.1643230976188;3395.641743302674;3401.268727223634;3434.9484757728655;3446;5118.771494841211;5166.5866730661455;5172.974135129338;5173.32746742921;5189.143791274435;4600.930986035212;4653.790579423934;4655.208614535537;4663.253879379317;4669.626429885601;5312.76092575835;5530.479118242475;5548.4174161713245;5644.971775141139;5665;3798.8480460781534;3814.0548320356543;3846.192299617084;3850.690765139838;3850.7497012694084;5926;5932.529470259903;5964.224650795369;5971.790437538139;5973.701314934279;3818.3699689551468;3860.3630400983525;3865.1110244643887;3880.359740642819;3883;3936.9370270027507;3939.428782826474;3941.7240793144206;3947.9013024674036;3955.2003838253527;4627.097715945426;4629.189891768927;4646.047560250141;4654.325122857167;4657.441107067174;5053.84838454847;5578.888422231533;5591.384947655754;5629.605927585111;5703.231998080609;1358.1918758338772;1377.1943413103447;1383.840858301288;1384.5084994826893;1385.5843247025853;828.1263267253106;834.0825092398313;858.948463092204;866.4844417571661;868.452874688942;4677.4854765975715;4687.859364219079;5085.635179641485;5202.297689811902;5277.947220527745;5835.766569337179;5852.561057920588;5880.676562789087;5890.352061273256;5904.970475147683;5348.545373643284;5368.758405871745;5423.159410291411;5423.891522169534;5447.155690867922;2939.5737618045264;3084.599002129709;3108.8290144041844;3120.329129237225;3160.415323165176;5846.8538286542325;5849.151872978395;5908.704564771744;5968.7015649217365;5994.670293133832;5657.915131273035;5859.472647461749;5883.470487656132;5932.495737862244;5991.370906054802;5835.649861008353;5847.210626565445;5870.295564532198;5939.910901336483;5942.168096466412;5626.971865140648;5803.47768700819;5846.678432686073;5855.560832937462;5885.17607534954;5635.0702134147405;5657.236273103078;5657.745401456862;5697.914531282117;5740.540756739368;5809.170111414891;5851.824445266649;5877.882442351043;5938.584299099194;6039;3803.0872590578615;3879.670228030649;3898.3372826618975;3900.941485877771;3918.568957414739;5733.082706766897;5748.281464816898;5763.6541807491685;5777.8555536111935;5865.120231965239;5578.219049333178;5598.468145526169;5642.153676948491;5675.574331925205;5729.828105156852;5389.326334208224;5576.079946808731;5612.494875461228;5668.404817494269;5679.77280908759;5505.513511351993;5514.553404122424;5545.639533430314;5551.16890385898;5552.97223513896;5459.2629994950175;5470.64440811346;5622.2128901954575;5714.20001199824;5721.971390143022;5495.560355171657;5582.358028826737;5591.245181900392;5603.411641777555;5637.590602349413 10:26:49 INFO - PROCESS | 3272 | |5;yui.html;585.180746954264;611.4008271893542;673.8685956238533;690.2338404371151;702.9367356937875;13749.037567370275;13963.581092567214;14457.63855903603;14472.782908256371;14960.775588366156;12787.552435664753;12979.675508112301;13011.60965171044;13022.958163346933;13026.934865325684;566.5184593095856;656.1535619051418;656.258427976386;658.0688326018678;665.0523004718282;581.9418058194168;648.2933602373436;659.4790115808505;662.7547807311278;663.5123184459419;685.5646664368112;686.3445409633813;687.7283473028176;687.9208890977527;687.9690413931385;596.0493013643232;679.4971720926528;680.3196803196803;682.6893763337695;684.5037347922741;443.91787519308707;491.9655624106314;494.7427337784368;497.59197458084384;506.541579870218;12923;12974.740505189844;12984.805227921588;12988.220706757626;12993.48026078965;12013.399330033464;12225;12418.316992565406;12531.686707832287;12974.935125324408;10578.365298082139;10737.240827364045;10989.06592939601;11336.433178341133;12098.758024839542;3953.7627742335553;3977.940330895039;3981.6217459341315;4098.692598055158;4105.178964207171;59951.70024149851;61752.69123654398;61781.69109154426;62260.37739622591;62968.685156574385;9211.170994610517;9225.769355766159;9227.861582076273;9440.150386465251;9782.168515676247;16375.590610234602;17261.136943152793;17268.22292996793;17295.74056389155;17296.135193240538;7190.532615379983;7326.3406293433845;7376.409887209011;7388.15036270825;7416.925830741624;3917.2557214129224;4010.4585880905706;4014.6788256939376;4015.317396042621;4025.8993525162105;2921;3030.121264833218;3056.1137270191393;3058.3271680230314;3067.601211842446;471.9433667959798;475.7549861821165;476.09066682636;479.3744163866188;483.3233473137635;626.3204423200787;658.7365053978447;668.2916108924459;669.0666520204288;685.0477835808231;8447.32421406286;8652.394332396798;9060.818783624423;9090.500022498694;9687.854682179774;463.97680115994063;490.77669660304474;556.6298411556351;621.0466933257428;671.5064427645676;4302.612764851116;4349.412829268072;4414.84548040817;4456.064226512404;4555.134524440346;63113;74755.62622186854;82152.58923705343;84894.5755271232;85535.57232213799;68186.65906670534;71916;74302.25697743062;74774.62612686901;75505.24494755092;63555.68222158952;66168.33831661718;67227.32772672309;67590;68620.6568967152;8302.501849889026;8460.365472589703;8473.406861519881;8527.573621318785;8640.438371505832;38914.6108538911;38922.61077389303;39353.80323098366;40167.3974890371;40289.59710402859;53146.73426632842;55505.722471389;55602;56238.43761562332;57536.41086151217;11493.48279327449;11778.234414763014;11854.585089521825;11991.22057066288;12116;14332.641683957985;14342.49801256951;14856.108633482027;14959.326830292446;15197.164155971528;13250;13380.866191338351;13444.596662100153;13585.52450664222;13986.300684965914;11886.405679715806;12005.279683219034;12078.637640870787;12097.092718046006;12400.503979840705;12807.231566106064;12957.740845182854;13149.60551183466;13326.800097998344;13575.728485430434;10665.466726663792;10684.305520141166;10708.30396024256;10764.677059688222;10959.945200273947;9905.504724763878;10190.745231369276;10234.795304094025;10250.897491025293;10345.37927724339 10:26:49 INFO - PROCESS | 3272 | __end_tp_report 10:26:49 INFO - PROCESS | 3272 | __start_cc_report 10:26:49 INFO - PROCESS | 3272 | _x_x_mozilla_cycle_collect,1066 10:26:49 INFO - PROCESS | 3272 | __end_cc_report 10:26:49 INFO - PROCESS | 3272 | __startTimestamp1476466009618__endTimestamp 10:26:49 INFO - PROCESS | 3272 | 10:26:49 INFO - PROCESS | 3272 | ------- Summary: start ------- 10:26:49 INFO - PROCESS | 3272 | Number of tests: 6 10:26:49 INFO - PROCESS | 3272 | 10:26:49 INFO - PROCESS | 3272 | [#0] dojo.html Cycles:165 Average:5167.51 Median:5474.10 stddev:692.23 (12.6%) stddev-sans-first:670.20 10:26:49 INFO - PROCESS | 3272 | Values: 2857.0 2879.9 2882.8 2913.1 2925.3 5141.5 5259.3 5277.6 5298.8 5330.3 5171.5 5226.0 5247.7 5257.8 5272.3 4686.4 4691.2 4699.9 4718.6 4753.6 4743.4 4769.0 4770.5 4772.3 4772.6 4692.3 4721.3 4748.0 4750.5 4766.5 4750.0 4750.0 4780.2 4792.5 4846.2 4442.4 4591.7 4695.5 4705.7 4796.8 5170.9 5198.7 5216.0 5230.1 5266.6 5510.2 5550.6 5577.1 5608.8 5616.1 5564.5 5656.1 5662.1 5666.7 5715.6 5147.8 5181.0 5200.8 5217.9 5219.2 5730.7 5765.1 5771.2 5797.4 5801.1 5496.6 5530.3 5531.8 5541.2 5542.4 5572.7 5618.7 5621.2 5686.6 5687.3 5519.9 5534.8 5575.4 5630.7 5655.6 5581.0 5589.3 5590.3 5632.4 5653.2 3699.8 3709.2 3710.1 3715.1 3754.8 3295.5 3335.7 3336.1 3343.4 3383.9 5220.7 5225.7 5226.1 5226.8 5229.4 5601.2 5603.8 5606.4 5609.1 5648.9 5178.1 5188.1 5219.6 5226.1 5237.6 4585.7 4629.3 4630.7 4631.3 4635.0 5714.0 5794.4 5799.2 5804.6 5811.4 5653.3 5657.0 5671.2 5713.1 5719.4 5823.6 5828.8 5831.2 5847.6 5851.5 5460.3 5513.9 5594.8 5635.7 5640.0 5593.1 5665.8 5672.9 5692.5 5710.5 5511.5 5513.6 5523.4 5525.0 5528.6 5522.1 5527.2 5529.2 5531.7 5574.4 5230.4 5312.3 5400.3 5423.0 5423.3 5526.4 5554.1 5559.1 5563.8 5612.9 5472.2 5474.1 5488.7 5491.2 5496.0 10:26:49 INFO - PROCESS | 3272 | 10:26:49 INFO - PROCESS | 3272 | [#1] ext.html Cycles:180 Average:47915.88 Median:36582.86 stddev:91202.93 (249.3%) stddev-sans-first:91389.42 10:26:49 INFO - PROCESS | 3272 | Values: 541.6 553.6 553.6 555.7 564.3 29279.3 30431.2 32340.4 36840.6 37919.0 38365.0 38791.2 39196.0 39220.4 39241.0 8294.7 8446.8 8451.3 8459.6 8460.3 7882.6 8067.1 8247.3 8306.5 9680.2 9981.4 10246.8 10296.1 10316.7 10319.6 9959.8 10012.1 10067.9 10083.6 10087.2 7937.2 8193.3 9586.8 9902.3 9905.2 36556.3 36609.5 36770.4 36858.6 36884.3 2822.1 2828.4 2905.0 3338.2 3556.8 28429.6 28665.4 28691.1 28702.4 28722.1 3790.4 3802.0 3838.9 3840.4 3921.7 263023.0 281871.0 284108.0 284424.0 284848.0 42088.6 43499.0 45170.8 45490.5 46213.8 49040.0 49169.0 49370.0 49370.8 49429.8 12944.5 13037.9 13073.9 13088.3 13091.6 9779.6 9859.7 9895.3 9898.4 9912.8 12460.3 12477.9 13033.8 13388.9 13603.5 4959.2 5042.2 5105.6 5175.7 5274.5 709.4 797.1 925.7 934.0 934.5 25186.7 25711.6 26385.2 26506.0 26660.6 883.5 895.6 914.3 924.8 980.9 13571.6 13835.5 13933.0 14029.4 14100.0 409835.0 413669.0 413855.0 414746.0 418085.0 44795.8 45032.0 45071.5 45113.1 45126.0 994.0 1004.2 1010.4 1036.9 1090.5 25116.4 27042.6 27434.0 27434.7 27449.6 39105.0 39376.6 39520.6 39547.0 39567.6 315225.0 331068.0 331699.0 332721.0 333205.0 23868.9 24307.5 24378.1 24643.9 24949.3 39704.2 39770.8 40349.8 40389.0 40828.6 34157.8 34202.5 34487.0 34687.3 34967.5 34282.8 34568.8 34680.0 34688.7 34835.3 32700.3 32886.7 33272.7 33333.8 33377.8 30292.2 31490.7 31652.7 31802.5 31817.8 23520.9 23758.9 23807.8 24044.9 24215.6 10:26:49 INFO - PROCESS | 3272 | 10:26:49 INFO - PROCESS | 3272 | [#2] jquery.html Cycles:180 Average:24241.32 Median:4443.03 stddev:65254.53 (1468.7%) stddev-sans-first:65412.88 10:26:49 INFO - PROCESS | 3272 | Values: 325.2 337.8 341.8 342.8 359.6 13260.1 14162.9 15936.6 16162.6 16392.5 13083.5 13268.1 13291.9 13961.4 14918.1 5098.5 5294.6 5308.1 5309.9 5313.6 4907.4 4983.8 5231.9 5274.9 5302.7 5220.6 5239.3 5248.7 5249.2 5250.3 5044.8 5213.1 5234.0 5243.3 5247.2 4663.9 4678.3 4678.5 4679.3 4680.9 19371.2 19589.3 19645.9 19927.5 20133.3 1844.4 1850.4 1897.4 1908.8 1976.2 8669.0 12360.6 13093.9 13596.3 13610.1 1800.7 1855.7 1879.3 1880.0 1890.7 67254.0 68065.0 69145.0 69584.7 73404.3 9640.2 9717.1 9820.3 9847.2 9866.8 13114.5 13117.9 13135.5 13137.7 13156.6 6748.4 6789.2 6879.3 6885.9 6914.1 6342.0 6373.1 6466.3 6477.6 6495.0 4058.5 4142.0 4149.3 4177.6 4222.2 1567.5 1618.7 1679.1 1681.9 1697.9 752.4 775.2 818.7 845.5 909.9 16368.2 16791.5 17056.7 17117.2 17234.4 776.7 784.1 790.2 807.7 808.4 8981.2 9275.9 9344.8 9370.8 9429.7 386906.0 394417.0 395645.0 396049.0 401442.0 78009.0 78810.0 79159.6 80572.6 81391.2 858.0 878.5 879.1 879.3 879.7 14528.8 14688.6 14711.3 14858.9 15104.7 35603.5 35612.8 36003.5 36179.7 37012.0 48681.0 48766.3 49518.5 49557.3 49580.3 6616.7 7049.0 7145.7 7388.0 7709.6 11487.7 11931.3 12197.0 12317.1 12520.4 10119.7 10297.3 10505.1 10571.6 10792.1 10150.3 10510.8 10631.9 10703.1 10843.9 7317.0 9315.3 10340.3 10849.2 10882.1 7453.0 7517.7 7557.5 7792.3 7989.2 7757.9 10005.5 10322.0 10336.8 10396.1 10:26:49 INFO - PROCESS | 3272 | 10:26:49 INFO - PROCESS | 3272 | [#3] mootools.html Cycles:180 Average:4969.19 Median:4811.73 stddev:2925.83 (60.8%) stddev-sans-first:2919.66 10:26:49 INFO - PROCESS | 3272 | Values: 1109.9 1128.2 1139.7 1215.8 1423.9 6946.3 7446.7 7714.1 7741.9 7757.3 7734.0 7760.8 7783.6 7787.9 7799.8 2017.8 2041.3 2043.5 2044.3 2045.0 1946.8 1952.7 1957.5 1977.7 1982.5 1935.0 1951.4 1953.4 1955.6 1958.0 1933.8 1934.8 1937.2 1938.7 1947.1 1923.2 1928.8 1936.9 1984.7 1993.1 7649.0 7703.2 7727.8 7746.3 7747.6 4168.9 4328.1 4334.2 4334.3 4340.5 2945.6 3025.7 3059.9 3067.8 3082.3 988.4 990.2 1005.2 1007.0 1014.3 10693.5 10698.4 10702.4 10733.9 10746.9 3680.8 3980.4 4104.7 4108.8 4135.9 8401.1 8466.7 8480.4 8490.1 8495.6 4353.1 4354.0 4356.9 4359.1 4365.2 3595.1 3744.9 3863.6 4065.4 4067.5 3324.2 3359.7 3363.5 3395.5 3446.9 985.5 989.5 990.4 991.6 999.6 638.8 772.3 781.6 782.2 786.5 4899.7 4913.8 4969.1 5029.2 5117.1 364.2 367.0 370.1 370.6 381.2 3329.7 3351.9 3371.9 3397.4 3425.2 9353.3 9694.7 9722.9 9725.1 9745.5 9669.2 9674.9 9686.8 9705.4 9713.8 7256.2 7271.6 7335.1 7377.0 7396.6 4730.5 4765.2 4773.3 4850.1 4910.7 8863.8 8920.2 8972.2 9015.8 9035.4 8111.4 8520.3 8773.1 8866.0 9150.8 6569.3 6700.9 6703.1 6708.2 6717.2 7285.5 7395.8 7471.2 7509.6 7529.2 6688.1 6729.2 6780.3 6795.7 6887.6 6372.7 6534.7 6612.5 6638.5 6728.8 6217.0 6281.4 6315.0 6349.3 6355.9 4109.1 4132.2 4146.2 4201.0 4252.7 4130.7 4157.3 4167.8 4173.6 4232.6 10:26:49 INFO - PROCESS | 3272 | 10:26:49 INFO - PROCESS | 3272 | [#4] prototype.html Cycles:180 Average:4653.60 Median:5368.64 stddev:1433.17 (26.7%) stddev-sans-first:1399.22 10:26:49 INFO - PROCESS | 3272 | Values: 287.3 288.8 292.2 292.5 296.7 5189.7 5362.6 5368.5 5409.4 5435.0 5277.4 5293.0 5309.5 5310.7 5354.9 3755.6 3886.9 4007.5 4015.4 4039.6 3717.4 3959.5 3966.5 4014.6 4019.9 3933.3 3996.8 3997.8 4007.9 4029.9 3960.4 3978.4 3991.2 3995.2 4033.2 3277.2 3395.6 3401.3 3434.9 3446.0 5118.8 5166.6 5173.0 5173.3 5189.1 4600.9 4653.8 4655.2 4663.3 4669.6 5312.8 5530.5 5548.4 5645.0 5665.0 3798.8 3814.1 3846.2 3850.7 3850.7 5926.0 5932.5 5964.2 5971.8 5973.7 3818.4 3860.4 3865.1 3880.4 3883.0 3936.9 3939.4 3941.7 3947.9 3955.2 4627.1 4629.2 4646.0 4654.3 4657.4 5053.8 5578.9 5591.4 5629.6 5703.2 1358.2 1377.2 1383.8 1384.5 1385.6 828.1 834.1 858.9 866.5 868.5 4677.5 4687.9 5085.6 5202.3 5277.9 5835.8 5852.6 5880.7 5890.4 5905.0 5348.5 5368.8 5423.2 5423.9 5447.2 2939.6 3084.6 3108.8 3120.3 3160.4 5846.9 5849.2 5908.7 5968.7 5994.7 5657.9 5859.5 5883.5 5932.5 5991.4 5835.6 5847.2 5870.3 5939.9 5942.2 5627.0 5803.5 5846.7 5855.6 5885.2 5635.1 5657.2 5657.7 5697.9 5740.5 5809.2 5851.8 5877.9 5938.6 6039.0 3803.1 3879.7 3898.3 3900.9 3918.6 5733.1 5748.3 5763.7 5777.9 5865.1 5578.2 5598.5 5642.2 5675.6 5729.8 5389.3 5576.1 5612.5 5668.4 5679.8 5505.5 5514.6 5545.6 5551.2 5553.0 5459.3 5470.6 5622.2 5714.2 5722.0 5495.6 5582.4 5591.2 5603.4 5637.6 10:26:49 INFO - PROCESS | 3272 | 10:26:49 INFO - PROCESS | 3272 | [#5] yui.html Cycles:180 Average:16580.91 Median:467.96 stddev:21832.12 (4665.4%) stddev-sans-first:21860.32 10:26:49 INFO - PROCESS | 3272 | Values: 585.2 611.4 673.9 690.2 702.9 13749.0 13963.6 14457.6 14472.8 14960.8 12787.6 12979.7 13011.6 13023.0 13026.9 566.5 656.2 656.3 658.1 665.1 581.9 648.3 659.5 662.8 663.5 685.6 686.3 687.7 687.9 688.0 596.0 679.5 680.3 682.7 684.5 443.9 492.0 494.7 497.6 506.5 12923.0 12974.7 12984.8 12988.2 12993.5 12013.4 12225.0 12418.3 12531.7 12974.9 10578.4 10737.2 10989.1 11336.4 12098.8 3953.8 3977.9 3981.6 4098.7 4105.2 59951.7 61752.7 61781.7 62260.4 62968.7 9211.2 9225.8 9227.9 9440.2 9782.2 16375.6 17261.1 17268.2 17295.7 17296.1 7190.5 7326.3 7376.4 7388.2 7416.9 3917.3 4010.5 4014.7 4015.3 4025.9 2921.0 3030.1 3056.1 3058.3 3067.6 471.9 475.8 476.1 479.4 483.3 626.3 658.7 668.3 669.1 685.0 8447.3 8652.4 9060.8 9090.5 9687.9 464.0 490.8 556.6 621.0 671.5 4302.6 4349.4 4414.8 4456.1 4555.1 63113.0 74755.6 82152.6 84894.6 85535.6 68186.7 71916.0 74302.3 74774.6 75505.2 63555.7 66168.3 67227.3 67590.0 68620.7 8302.5 8460.4 8473.4 8527.6 8640.4 38914.6 38922.6 39353.8 40167.4 40289.6 53146.7 55505.7 55602.0 56238.4 57536.4 11493.5 11778.2 11854.6 11991.2 12116.0 14332.6 14342.5 14856.1 14959.3 15197.2 13250.0 13380.9 13444.6 13585.5 13986.3 11886.4 12005.3 12078.6 12097.1 12400.5 12807.2 12957.7 13149.6 13326.8 13575.7 10665.5 10684.3 10708.3 10764.7 10959.9 9905.5 10190.7 10234.8 10250.9 10345.4 10:26:49 INFO - PROCESS | 3272 | -------- Summary: end -------- 10:26:49 INFO - PROCESS | 3272 | 10:26:50 INFO - TEST-INFO | 3272: exit 0 10:26:50 INFO - TEST-OK | dromaeo_css | took 1127965ms 10:26:50 INFO - TEST-START | kraken 10:26:50 INFO - operating with platform_type : w8_ 10:26:50 INFO - Initialising browser for kraken test... 10:26:50 INFO - TEST-INFO | started process 2240 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpcpvda1\profile http://localhost:49274/getInfo.html) 10:26:56 INFO - PROCESS | 2240 | __metrics Screen width/height:1600/1200 10:26:56 INFO - PROCESS | 2240 | colorDepth:24 10:26:56 INFO - PROCESS | 2240 | Browser inner width/height: 1010/674 10:26:56 INFO - PROCESS | 2240 | __metrics 10:26:57 INFO - PROCESS | 2240 | 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" 10:26:57 INFO - PROCESS | 2240 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:26:57 INFO - PROCESS | 2240 | console.error: 10:26:57 INFO - PROCESS | 2240 | Message: Error: Connection closed before committing the transaction. 10:26:57 INFO - PROCESS | 2240 | Stack: 10:26:57 INFO - PROCESS | 2240 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 10:26:57 INFO - PROCESS | 2240 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 10:26:57 INFO - PROCESS | 2240 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 10:26:57 INFO - PROCESS | 2240 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 10:26:57 INFO - PROCESS | 2240 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 10:26:57 INFO - PROCESS | 2240 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 10:26:57 INFO - PROCESS | 2240 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 10:26:57 INFO - PROCESS | 2240 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 10:26:57 INFO - PROCESS | 2240 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 10:26:57 INFO - PROCESS | 2240 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 10:26:57 INFO - PROCESS | 2240 | Barrier/this.client.addBlocker/promise13.2% 10:27:54 INFO - TinderboxPrint: I/O read bytes / time
245,505,024 / 6,002,620 10:27:54 INFO - TinderboxPrint: I/O write bytes / time
411,590,656 / 4,714,980 10:27:54 INFO - TinderboxPrint: CPU idle
8,306.5 (86.8%) 10:27:54 INFO - TinderboxPrint: CPU user
1,219.9 (12.7%) 10:27:54 INFO - install - Wall time: 3s; CPU: 12.0%; Read bytes: 0; Write bytes: 33165824; Read time: 0; Write time: 40500 10:27:54 INFO - run-tests - Wall time: 1195s; CPU: 13.0%; Read bytes: 245505024; Write bytes: 322368512; Read time: 6002620; Write time: 4589860 10:27:55 INFO - Running post-run listener: _upload_blobber_files 10:27:55 INFO - Blob upload gear active. 10:27:55 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 10:27:55 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 10:27:55 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Firefox', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 10:27:55 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Firefox -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 10:27:55 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:55 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 10:27:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:27:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:56 INFO - (blobuploader) - INFO - Done attempting. 10:27:56 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 10:27:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:27:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:57 INFO - (blobuploader) - INFO - Done attempting. 10:27:57 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 10:27:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:28:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:01 INFO - (blobuploader) - INFO - Done attempting. 10:28:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:01 INFO - Return code: 0 10:28:01 INFO - rmtree: C:\slave\test\build\uploaded_files.json 10:28:01 INFO - Using _rmtree_windows ... 10:28:01 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 10:28:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af2e96cfae9d1c25368646abc82f70c81d2d0d472d6098c242576a5ba399b368b7c621b24aa67f134d8f5bc9cc5985f940ddfb6df0ae0ef40fd8143463e9387", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd34a1f7957a7ab4fd5794d9f3b9ca88e78ee1c3ae1914cef3f9f5521caf5e5a7eeee3aa9079262d0de819683db728af4ba97bf935fb68f46892ec24bc985fd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ab73001701c627f262b7db2bf2c5e3f8f0d4e2c02fd2f0534ffeb2b73eae2b03e0967a4a52b6fc211d77150cd3ffefda8c13ab5ade59a229f96dec598cf5258"} 10:28:01 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 10:28:01 INFO - Writing to file C:\slave\test\properties\blobber_files 10:28:01 INFO - Contents: 10:28:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af2e96cfae9d1c25368646abc82f70c81d2d0d472d6098c242576a5ba399b368b7c621b24aa67f134d8f5bc9cc5985f940ddfb6df0ae0ef40fd8143463e9387", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd34a1f7957a7ab4fd5794d9f3b9ca88e78ee1c3ae1914cef3f9f5521caf5e5a7eeee3aa9079262d0de819683db728af4ba97bf935fb68f46892ec24bc985fd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ab73001701c627f262b7db2bf2c5e3f8f0d4e2c02fd2f0534ffeb2b73eae2b03e0967a4a52b6fc211d77150cd3ffefda8c13ab5ade59a229f96dec598cf5258"} 10:28:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:28:01 INFO - Copying logs to upload dir... 10:28:01 INFO - mkdir: C:\slave\test\build\upload\logs 10:28:01 INFO - Copying logs to upload dir... 10:28:01 INFO - Using _rmtree_windows ... 10:28:01 INFO - Using _rmtree_windows ... 10:28:01 INFO - Using _rmtree_windows ... 10:28:01 INFO - Using _rmtree_windows ... 10:28:01 INFO - Using _rmtree_windows ... 10:28:01 INFO - Using _rmtree_windows ... 10:28:01 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1449.655000 ========= master_lag: -0.27 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 9 secs) (at 2016-10-14 10:28:01.485106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:28:01.485721) ========= '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-066\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-066 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-066 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-066\AppData\Local LOGONSERVER=\\T-W864-IX-066 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-066 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-066 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-066 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af2e96cfae9d1c25368646abc82f70c81d2d0d472d6098c242576a5ba399b368b7c621b24aa67f134d8f5bc9cc5985f940ddfb6df0ae0ef40fd8143463e9387", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd34a1f7957a7ab4fd5794d9f3b9ca88e78ee1c3ae1914cef3f9f5521caf5e5a7eeee3aa9079262d0de819683db728af4ba97bf935fb68f46892ec24bc985fd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ab73001701c627f262b7db2bf2c5e3f8f0d4e2c02fd2f0534ffeb2b73eae2b03e0967a4a52b6fc211d77150cd3ffefda8c13ab5ade59a229f96dec598cf5258"} build_url:https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/O_GtF_DnT_27U26Q0zG17w/artifacts/public/build/firefox-52.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af2e96cfae9d1c25368646abc82f70c81d2d0d472d6098c242576a5ba399b368b7c621b24aa67f134d8f5bc9cc5985f940ddfb6df0ae0ef40fd8143463e9387", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd34a1f7957a7ab4fd5794d9f3b9ca88e78ee1c3ae1914cef3f9f5521caf5e5a7eeee3aa9079262d0de819683db728af4ba97bf935fb68f46892ec24bc985fd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ab73001701c627f262b7db2bf2c5e3f8f0d4e2c02fd2f0534ffeb2b73eae2b03e0967a4a52b6fc211d77150cd3ffefda8c13ab5ade59a229f96dec598cf5258"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:28:01.614203) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:28:01.614520) ========= '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-066\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-066 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-066 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-066\AppData\Local LOGONSERVER=\\T-W864-IX-066 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-066 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-066 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-066 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.102000 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:28:01.734061) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-14 10:28:01.734390) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-14 10:28:02.165909) ========= ========= Total master_lag: 0.19 =========