builder: mozilla-central_win8_64_test-dromaeojs-pgo slave: t-w864-ix-145 starttime: 1476803315.64 results: success (0) buildid: 20161018043003 builduid: 032949a240c042588b2c75790453aff5 revision: dc89484d4b45abf442162e5ea2dd46f9de40197d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 08:08:35.640615) ========= master: http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 08:08:35.641068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 08:08:35.641344) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 08:08:35.746642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 08:08:35.747053) ========= '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-145\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-145 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-145 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-145\AppData\Local LOGONSERVER=\\T-W864-IX-145 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-145 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-145 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-145 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --08:08:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure HTTP request sent, awaiting response... 200 Script output follows Length: 12,179 (12K) [text/x-python] 0K .......... . 100% 7.57 MB/s 08:08:37 (7.57 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.444000 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 08:08:37.254374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-18 08:08:37.254712) ========= '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-145\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-145 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-145 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-145\AppData\Local LOGONSERVER=\\T-W864-IX-145 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-145 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-145 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-145 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=3.307000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-18 08:08:40.577840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-18 08:08:40.578214) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev dc89484d4b45abf442162e5ea2dd46f9de40197d --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 dc89484d4b45abf442162e5ea2dd46f9de40197d --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-145\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-145 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-145 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-145\AppData\Local LOGONSERVER=\\T-W864-IX-145 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-145 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-145 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-145 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-18 08:08:40,904 truncating revision to first 12 chars 2016-10-18 08:08:40,904 Setting DEBUG logging. 2016-10-18 08:08:40,904 attempt 1/10 2016-10-18 08:08:40,904 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dc89484d4b45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 08:08:42,285 unpacking tar archive at: mozilla-central-dc89484d4b45/testing/mozharness/ 2016-10-18 08:08:42,387 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=2.065000 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-18 08:08:42.766237) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 08:08:42.766567) ========= script_repo_revision: dc89484d4b45abf442162e5ea2dd46f9de40197d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 08:08:42.766961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 08:08:42.767226) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 08:08:42.785335) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 23 secs) (at 2016-10-18 08:08:42.785675) ========= '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-145\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-145 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-145 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-145\AppData\Local LOGONSERVER=\\T-W864-IX-145 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-145 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-145 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-145 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 08:08:43 INFO - MultiFileLogger online at 20161018 08:08:43 in C:\slave\test 08:08:43 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 08:08:43 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 08:08:43 INFO - {'append_to_log': False, 08:08:43 INFO - 'base_work_dir': 'C:\\slave\\test', 08:08:43 INFO - 'blob_upload_branch': 'Firefox', 08:08:43 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 08:08:43 INFO - 'branch': 'Firefox', 08:08:43 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:43 INFO - 'config_files': ('talos/windows_config.py',), 08:08:43 INFO - 'default_actions': ('clobber', 08:08:43 INFO - 'read-buildbot-config', 08:08:43 INFO - 'download-and-extract', 08:08:43 INFO - 'populate-webroot', 08:08:43 INFO - 'create-virtualenv', 08:08:43 INFO - 'install', 08:08:43 INFO - 'run-tests'), 08:08:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:43 INFO - 'download_minidump_stackwalk': True, 08:08:43 INFO - 'download_symbols': 'ondemand', 08:08:43 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 08:08:43 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 08:08:43 INFO - 'hg': 'c:/mozilla-build/hg/hg', 08:08:43 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 08:08:43 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 08:08:43 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 08:08:43 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 08:08:43 INFO - 'C:/mozilla-build/tooltool.py'), 08:08:43 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 08:08:43 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 08:08:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:43 INFO - 'installer_path': 'installer.exe', 08:08:43 INFO - 'log_level': 'info', 08:08:43 INFO - 'log_name': 'talos', 08:08:43 INFO - 'log_to_console': True, 08:08:43 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 08:08:43 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 08:08:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 08:08:43 INFO - 'opt_config_files': (), 08:08:43 INFO - 'pip_index': False, 08:08:43 INFO - 'sps_profile': False, 08:08:43 INFO - 'sps_profile_interval': 0, 08:08:43 INFO - 'suite': 'dromaeojs', 08:08:43 INFO - 'system_bits': '32', 08:08:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:43 INFO - 'title': 'T-W864-IX-145', 08:08:43 INFO - 'use_talos_json': True, 08:08:43 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 08:08:43 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 08:08:43 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 08:08:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:43 INFO - 'work_dir': 'build'} 08:08:43 INFO - [mozharness: 2016-10-18 15:08:43.077000Z] Running clobber step. 08:08:43 INFO - Running pre-action listener: _resource_record_pre_action 08:08:43 INFO - Running main action method: clobber 08:08:43 INFO - rmtree: C:\slave\test\build 08:08:43 INFO - Using _rmtree_windows ... 08:08:43 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 08:09:22 INFO - Running post-action listener: _resource_record_post_action 08:09:22 INFO - [mozharness: 2016-10-18 15:09:22.565000Z] Finished clobber step (success) 08:09:22 INFO - [mozharness: 2016-10-18 15:09:22.565000Z] Running read-buildbot-config step. 08:09:22 INFO - Running pre-action listener: _resource_record_pre_action 08:09:22 INFO - Running main action method: read_buildbot_config 08:09:22 INFO - Using buildbot properties: 08:09:22 INFO - { 08:09:22 INFO - "project": "", 08:09:22 INFO - "product": "firefox", 08:09:22 INFO - "script_repo_revision": "production", 08:09:22 INFO - "builddir": "mozilla-central_win8_64_test-dromaeojs", 08:09:22 INFO - "repository": "", 08:09:22 INFO - "buildername": "Windows 8 64-bit mozilla-central pgo talos dromaeojs", 08:09:22 INFO - "buildid": "20161018043003", 08:09:22 INFO - "pgo_build": "True", 08:09:22 INFO - "basedir": "C:\\slave\\test", 08:09:22 INFO - "buildnumber": 3, 08:09:22 INFO - "slavename": "t-w864-ix-145", 08:09:22 INFO - "master": "http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/", 08:09:22 INFO - "platform": "win8_64", 08:09:22 INFO - "scheduler": "tests-mozilla-central-win64-pgo-talos", 08:09:22 INFO - "branch": "mozilla-central", 08:09:22 INFO - "repo_path": "mozilla-central", 08:09:22 INFO - "revision": "dc89484d4b45abf442162e5ea2dd46f9de40197d", 08:09:22 INFO - "stage_platform": "win64-pgo", 08:09:22 INFO - "builduid": "032949a240c042588b2c75790453aff5", 08:09:22 INFO - "slavebuilddir": "test" 08:09:22 INFO - } 08:09:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 08:09:22 INFO - Running post-action listener: _resource_record_post_action 08:09:22 INFO - [mozharness: 2016-10-18 15:09:22.568000Z] Finished read-buildbot-config step (success) 08:09:22 INFO - [mozharness: 2016-10-18 15:09:22.569000Z] Running download-and-extract step. 08:09:22 INFO - Running pre-action listener: _resource_record_pre_action 08:09:22 INFO - Running main action method: download_and_extract 08:09:22 INFO - mkdir: C:\slave\test\build\tests 08:09:22 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')]} 08:09:22 INFO - trying https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 08:09:22 INFO - Downloading https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/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 08:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/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 08:09:23 INFO - Downloaded 1218 bytes. 08:09:23 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 08:09:23 INFO - Using the following test package requirements: 08:09:23 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 08:09:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 08:09:23 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 08:09:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 08:09:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 08:09:23 INFO - u'jsshell-win64.zip'], 08:09:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 08:09:23 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 08:09:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 08:09:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 08:09:23 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 08:09:23 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 08:09:23 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 08:09:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 08:09:23 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 08:09:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 08:09:23 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 08:09:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 08:09:23 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 08:09:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 08:09:23 INFO - Fetch https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 08:09:24 INFO - Http code: 200 08:09:24 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 08:09:24 INFO - x-amz-cf-id: BJkPPiKctoQr7aMpVfwC5Ic9R4z9crOraOd-guH8vcEmpySRDFBV7w== 08:09:24 INFO - x-amz-version-id: gcOVQZZCurksMYlq_oSasiy.k_NjiZiH 08:09:24 INFO - Expected file size: 17525370 08:09:24 INFO - Obtained file size: 17525370 08:09:51 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 08:09:51 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 08:09:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 08:09:51 INFO - Fetch https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 08:09:52 INFO - Http code: 200 08:09:52 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 08:09:52 INFO - x-amz-cf-id: oBHkabCkIF3UZqDM5v4MeKfdP-r4ip9L2S4ZeUtSi6BCo5GkvrLNpg== 08:09:52 INFO - x-amz-version-id: gcOVQZZCurksMYlq_oSasiy.k_NjiZiH 08:09:52 INFO - Expected file size: 17525370 08:09:52 INFO - Obtained file size: 17525370 08:10:00 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 08:10:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 08:10:00 INFO - Fetch https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 08:10:01 INFO - Http code: 200 08:10:01 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 08:10:01 INFO - x-amz-cf-id: vF7GNN0U-l2NhE3S71oUC49qFz4qcorXin-Tw0DOqT77E3Daqgtouw== 08:10:01 INFO - x-amz-version-id: GUJ3es5pLMhpmUr.S_7QWk8lFT6b8V7p 08:10:01 INFO - Expected file size: 14409028 08:10:01 INFO - Obtained file size: 14409028 08:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:12 INFO - trying https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 08:10:12 INFO - Downloading https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 08:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/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 08:10:14 INFO - Downloaded 57305456 bytes. 08:10:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 08:10:14 INFO - mkdir: C:\slave\test\properties 08:10:14 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 08:10:14 INFO - Writing to file C:\slave\test\properties\build_url 08:10:14 INFO - Contents: 08:10:14 INFO - build_url:https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 08:10:15 INFO - Running post-action listener: _resource_record_post_action 08:10:15 INFO - Running post-action listener: set_extra_try_arguments 08:10:15 INFO - [mozharness: 2016-10-18 15:10:15.362000Z] Finished download-and-extract step (success) 08:10:15 INFO - [mozharness: 2016-10-18 15:10:15.362000Z] Running populate-webroot step. 08:10:15 INFO - Running pre-action listener: _resource_record_pre_action 08:10:15 INFO - Running main action method: populate_webroot 08:10:15 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 08:10:15 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 08:10:15 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 08:10:15 INFO - u'--tppagecycles', 08:10:15 INFO - u'7'], 08:10:15 INFO - u'tests': [u'tsvgm']}}, 08:10:15 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 08:10:15 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 08:10:15 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 08:10:15 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 08:10:15 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 08:10:15 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 08:10:15 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:15 INFO - u'talos_options': [u'--disable-e10s'], 08:10:15 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 08:10:15 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:15 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 08:10:15 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:15 INFO - u'talos_options': [u'--disable-e10s'], 08:10:15 INFO - u'tests': [u'damp', u'tps']}, 08:10:15 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:15 INFO - u'tests': [u'damp', u'tps']}, 08:10:15 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 08:10:15 INFO - u'tests': [u'dromaeo_dom']}, 08:10:15 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 08:10:15 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 08:10:15 INFO - u'tests': [u'basic_compositor_video']}, 08:10:15 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 08:10:15 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 08:10:15 INFO - u'tests': [u'a11yr', 08:10:15 INFO - u'ts_paint', 08:10:15 INFO - u'tpaint', 08:10:15 INFO - u'sessionrestore', 08:10:15 INFO - u'sessionrestore_no_auto_restore', 08:10:15 INFO - u'tabpaint']}, 08:10:15 INFO - u'other-e10s': {u'tests': [u'a11yr', 08:10:15 INFO - u'ts_paint', 08:10:15 INFO - u'tpaint', 08:10:15 INFO - u'sessionrestore', 08:10:15 INFO - u'sessionrestore_no_auto_restore', 08:10:15 INFO - u'tabpaint']}, 08:10:15 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 08:10:15 INFO - u'ts_paint', 08:10:15 INFO - u'tpaint', 08:10:15 INFO - u'sessionrestore', 08:10:15 INFO - u'sessionrestore_no_auto_restore', 08:10:15 INFO - u'tabpaint']}, 08:10:15 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 08:10:15 INFO - u'ts_paint', 08:10:15 INFO - u'tpaint', 08:10:15 INFO - u'sessionrestore', 08:10:15 INFO - u'sessionrestore_no_auto_restore', 08:10:15 INFO - u'tabpaint']}, 08:10:15 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 08:10:15 INFO - u'tests': [u'a11yr', 08:10:15 INFO - u'ts_paint', 08:10:15 INFO - u'tpaint', 08:10:15 INFO - u'sessionrestore', 08:10:15 INFO - u'sessionrestore_no_auto_restore', 08:10:15 INFO - u'tabpaint']}, 08:10:15 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 08:10:15 INFO - u'tests': [u'a11yr', 08:10:15 INFO - u'ts_paint', 08:10:15 INFO - u'tpaint', 08:10:15 INFO - u'sessionrestore', 08:10:15 INFO - u'sessionrestore_no_auto_restore', 08:10:15 INFO - u'tabpaint']}, 08:10:15 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 08:10:15 INFO - u'tests': [u'tsvgx', 08:10:15 INFO - u'tsvgr_opacity', 08:10:15 INFO - u'tart', 08:10:15 INFO - u'tscrollx', 08:10:15 INFO - u'cart']}, 08:10:15 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 08:10:15 INFO - u'tsvgr_opacity', 08:10:15 INFO - u'tart', 08:10:15 INFO - u'tscrollx', 08:10:15 INFO - u'cart']}, 08:10:15 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:15 INFO - u'talos_options': [u'--disable-e10s'], 08:10:15 INFO - u'tests': [u'tp5o']}, 08:10:15 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:15 INFO - u'tests': [u'tp5o']}, 08:10:15 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:15 INFO - u'talos_options': [u'--disable-e10s', 08:10:15 INFO - u'--xperf_path', 08:10:15 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:15 INFO - u'tests': [u'tp5n']}, 08:10:15 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:15 INFO - u'talos_options': [u'--xperf_path', 08:10:15 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:15 INFO - u'tests': [u'tp5n']}}, 08:10:15 INFO - u'talos.zip': {u'path': u'', 08:10:15 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:10:15 INFO - Running post-action listener: _resource_record_post_action 08:10:15 INFO - [mozharness: 2016-10-18 15:10:15.387000Z] Finished populate-webroot step (success) 08:10:15 INFO - [mozharness: 2016-10-18 15:10:15.387000Z] Running create-virtualenv step. 08:10:15 INFO - Running pre-action listener: _resource_record_pre_action 08:10:15 INFO - Running main action method: create_virtualenv 08:10:15 INFO - Creating virtualenv C:\slave\test\build/venv 08:10:15 INFO - mkdir: C:\slave\test\build\venv\Scripts 08:10:15 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 08:10:15 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'! 08:10:15 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 08:10:15 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 08:10:25 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 08:10:28 INFO - Installing distribute......................................................................................................................................................................................done. 08:10:29 INFO - Return code: 0 08:10:29 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 08:10:29 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 08:10:30 INFO - Reading from file tmpfile_stdout 08:10:30 INFO - Output received: 08:10:30 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 08:10:30 INFO - Using _rmtree_windows ... 08:10:30 INFO - Using _rmtree_windows ... 08:10:30 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 08:10:30 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')]} 08:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:30 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')]} 08:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:30 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 0x022DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028243E0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02338E90>, '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 0x01D5A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02864520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-145', 'USERDOMAIN': 'T-W864-IX-145', '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-145', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-145', '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-145\\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 08:10:30 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 08:10:30 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 08:10:30 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:10:30 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Roaming', 08:10:30 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:10:30 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:10:30 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:10:30 INFO - 'COMPUTERNAME': 'T-W864-IX-145', 08:10:30 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:10:30 INFO - 'DCLOCATION': 'SCL3', 08:10:30 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:10:30 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:10:30 INFO - 'HOMEDRIVE': 'C:', 08:10:30 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 08:10:30 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:10:30 INFO - 'KTS_VERSION': '1.19c', 08:10:30 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 08:10:30 INFO - 'LOGONSERVER': '\\\\T-W864-IX-145', 08:10:30 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:10:30 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:30 INFO - 'MOZ_NO_REMOTE': '1', 08:10:30 INFO - 'NO_EM_RESTART': '1', 08:10:30 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:10:30 INFO - 'OS': 'Windows_NT', 08:10:30 INFO - 'OURDRIVE': 'C:', 08:10:30 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', 08:10:30 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:10:30 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:10:30 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:10:30 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:10:30 INFO - 'PROCESSOR_LEVEL': '6', 08:10:30 INFO - 'PROCESSOR_REVISION': '1e05', 08:10:30 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:10:30 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:10:30 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:10:30 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:10:30 INFO - 'PROMPT': '$P$G', 08:10:30 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:10:30 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:10:30 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:10:30 INFO - 'PWD': 'C:\\slave\\test', 08:10:30 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:10:30 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:10:30 INFO - 'SYSTEMDRIVE': 'C:', 08:10:30 INFO - 'SYSTEMROOT': 'C:\\windows', 08:10:30 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:30 INFO - 'TEST1': 'testie', 08:10:30 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:30 INFO - 'USERDOMAIN': 'T-W864-IX-145', 08:10:30 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 08:10:30 INFO - 'USERNAME': 'cltbld', 08:10:30 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-145', 08:10:30 INFO - 'WINDIR': 'C:\\windows', 08:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:10:31 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:10:31 INFO - Downloading/unpacking pip>=1.5 08:10:35 INFO - Running setup.py egg_info for package pip 08:10:35 INFO - warning: no files found matching 'pip\cacert.pem' 08:10:35 INFO - warning: no files found matching '*.html' under directory 'docs' 08:10:35 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 08:10:35 INFO - no previously-included directories found matching 'docs\_build\_sources' 08:10:35 INFO - Installing collected packages: pip 08:10:35 INFO - Found existing installation: pip 0.8.2 08:10:35 INFO - Uninstalling pip: 08:10:35 INFO - Successfully uninstalled pip 08:10:35 INFO - Running setup.py install for pip 08:10:35 INFO - warning: no files found matching 'pip\cacert.pem' 08:10:35 INFO - warning: no files found matching '*.html' under directory 'docs' 08:10:35 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 08:10:35 INFO - no previously-included directories found matching 'docs\_build\_sources' 08:10:35 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 08:10:35 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 08:10:35 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 08:10:35 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 08:10:35 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 08:10:35 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 08:10:35 INFO - Successfully installed pip 08:10:35 INFO - Cleaning up... 08:10:35 INFO - Return code: 0 08:10:35 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 08:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:35 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x022DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028243E0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02338E90>, '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 0x01D5A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02864520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-145', 'USERDOMAIN': 'T-W864-IX-145', '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-145', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-145', '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-145\\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 08:10:35 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build 08:10:35 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:10:35 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:10:35 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Roaming', 08:10:35 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:10:35 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:10:35 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:10:35 INFO - 'COMPUTERNAME': 'T-W864-IX-145', 08:10:35 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:10:35 INFO - 'DCLOCATION': 'SCL3', 08:10:35 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:10:35 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:10:35 INFO - 'HOMEDRIVE': 'C:', 08:10:35 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 08:10:35 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:10:35 INFO - 'KTS_VERSION': '1.19c', 08:10:35 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 08:10:35 INFO - 'LOGONSERVER': '\\\\T-W864-IX-145', 08:10:35 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:10:35 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:35 INFO - 'MOZ_NO_REMOTE': '1', 08:10:35 INFO - 'NO_EM_RESTART': '1', 08:10:35 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:10:35 INFO - 'OS': 'Windows_NT', 08:10:35 INFO - 'OURDRIVE': 'C:', 08:10:35 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:10:35 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:10:35 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:10:35 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:10:35 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:10:35 INFO - 'PROCESSOR_LEVEL': '6', 08:10:35 INFO - 'PROCESSOR_REVISION': '1e05', 08:10:35 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:10:35 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:10:35 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:10:35 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:10:35 INFO - 'PROMPT': '$P$G', 08:10:35 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:10:35 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:10:35 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:10:35 INFO - 'PWD': 'C:\\slave\\test', 08:10:35 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:10:35 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:10:35 INFO - 'SYSTEMDRIVE': 'C:', 08:10:35 INFO - 'SYSTEMROOT': 'C:\\windows', 08:10:35 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:35 INFO - 'TEST1': 'testie', 08:10:35 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:35 INFO - 'USERDOMAIN': 'T-W864-IX-145', 08:10:35 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 08:10:35 INFO - 'USERNAME': 'cltbld', 08:10:35 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-145', 08:10:35 INFO - 'WINDIR': 'C:\\windows', 08:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:37 INFO - Downloading/unpacking psutil>=3.1.1 08:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:39 INFO - Installing collected packages: psutil 08:10:39 INFO - Successfully installed psutil 08:10:39 INFO - Cleaning up... 08:10:40 INFO - Return code: 0 08:10:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 08:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:40 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028243E0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02338E90>, '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 0x01D5A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02864520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-145', 'USERDOMAIN': 'T-W864-IX-145', '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-145', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-145', '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-145\\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 08:10:40 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build 08:10:40 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:10:40 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:10:40 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Roaming', 08:10:40 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:10:40 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:10:40 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:10:40 INFO - 'COMPUTERNAME': 'T-W864-IX-145', 08:10:40 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:10:40 INFO - 'DCLOCATION': 'SCL3', 08:10:40 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:10:40 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:10:40 INFO - 'HOMEDRIVE': 'C:', 08:10:40 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 08:10:40 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:10:40 INFO - 'KTS_VERSION': '1.19c', 08:10:40 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 08:10:40 INFO - 'LOGONSERVER': '\\\\T-W864-IX-145', 08:10:40 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:10:40 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:40 INFO - 'MOZ_NO_REMOTE': '1', 08:10:40 INFO - 'NO_EM_RESTART': '1', 08:10:40 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:10:40 INFO - 'OS': 'Windows_NT', 08:10:40 INFO - 'OURDRIVE': 'C:', 08:10:40 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:10:40 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:10:40 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:10:40 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:10:40 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:10:40 INFO - 'PROCESSOR_LEVEL': '6', 08:10:40 INFO - 'PROCESSOR_REVISION': '1e05', 08:10:40 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:10:40 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:10:40 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:10:40 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:10:40 INFO - 'PROMPT': '$P$G', 08:10:40 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:10:40 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:10:40 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:10:40 INFO - 'PWD': 'C:\\slave\\test', 08:10:40 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:10:40 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:10:40 INFO - 'SYSTEMDRIVE': 'C:', 08:10:40 INFO - 'SYSTEMROOT': 'C:\\windows', 08:10:40 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:40 INFO - 'TEST1': 'testie', 08:10:40 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:40 INFO - 'USERDOMAIN': 'T-W864-IX-145', 08:10:40 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 08:10:40 INFO - 'USERNAME': 'cltbld', 08:10:40 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-145', 08:10:40 INFO - 'WINDIR': 'C:\\windows', 08:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:10:40 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 08:10:40 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 08:10:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:10:41 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 08:10:41 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) 08:10:41 INFO - Installing collected packages: mozsystemmonitor 08:10:41 INFO - Running setup.py install for mozsystemmonitor 08:10:41 INFO - Successfully installed mozsystemmonitor 08:10:41 INFO - Cleaning up... 08:10:41 INFO - Return code: 0 08:10:41 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 08:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:41 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028243E0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02338E90>, '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 0x01D5A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02864520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-145', 'USERDOMAIN': 'T-W864-IX-145', '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-145', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-145', '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-145\\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 08:10:41 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build 08:10:41 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:10:41 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:10:41 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Roaming', 08:10:41 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:10:41 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:10:41 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:10:41 INFO - 'COMPUTERNAME': 'T-W864-IX-145', 08:10:41 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:10:41 INFO - 'DCLOCATION': 'SCL3', 08:10:41 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:10:41 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:10:41 INFO - 'HOMEDRIVE': 'C:', 08:10:41 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 08:10:41 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:10:41 INFO - 'KTS_VERSION': '1.19c', 08:10:41 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 08:10:41 INFO - 'LOGONSERVER': '\\\\T-W864-IX-145', 08:10:41 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:10:41 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:41 INFO - 'MOZ_NO_REMOTE': '1', 08:10:41 INFO - 'NO_EM_RESTART': '1', 08:10:41 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:10:41 INFO - 'OS': 'Windows_NT', 08:10:41 INFO - 'OURDRIVE': 'C:', 08:10:41 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:10:41 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:10:41 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:10:41 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:10:41 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:10:41 INFO - 'PROCESSOR_LEVEL': '6', 08:10:41 INFO - 'PROCESSOR_REVISION': '1e05', 08:10:41 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:10:41 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:10:41 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:10:41 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:10:41 INFO - 'PROMPT': '$P$G', 08:10:41 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:10:41 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:10:41 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:10:41 INFO - 'PWD': 'C:\\slave\\test', 08:10:41 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:10:41 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:10:41 INFO - 'SYSTEMDRIVE': 'C:', 08:10:41 INFO - 'SYSTEMROOT': 'C:\\windows', 08:10:41 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:41 INFO - 'TEST1': 'testie', 08:10:41 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:41 INFO - 'USERDOMAIN': 'T-W864-IX-145', 08:10:41 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 08:10:41 INFO - 'USERNAME': 'cltbld', 08:10:41 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-145', 08:10:41 INFO - 'WINDIR': 'C:\\windows', 08:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:42 INFO - Downloading/unpacking jsonschema==2.5.1 08:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:43 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 08:10:43 INFO - warning: no files found matching '*.txt' 08:10:43 INFO - no previously-included directories found matching 'build' 08:10:43 INFO - no previously-included directories found matching 'dist' 08:10:43 INFO - no previously-included directories found matching '.git*' 08:10:43 INFO - Installing collected packages: jsonschema, functools32 08:10:43 INFO - Running setup.py install for functools32 08:10:43 INFO - warning: no files found matching '*.txt' 08:10:43 INFO - no previously-included directories found matching 'build' 08:10:43 INFO - no previously-included directories found matching 'dist' 08:10:43 INFO - no previously-included directories found matching '.git*' 08:10:43 INFO - Successfully installed jsonschema functools32 08:10:43 INFO - Cleaning up... 08:10:44 INFO - Return code: 0 08:10:44 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 08:10:44 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')]} 08:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:44 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')]} 08:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:44 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 0x022DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028243E0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02338E90>, '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 0x01D5A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02864520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-145', 'USERDOMAIN': 'T-W864-IX-145', '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-145', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-145', '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-145\\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 08:10:44 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 08:10:44 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 08:10:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:10:44 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Roaming', 08:10:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:10:44 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:10:44 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:10:44 INFO - 'COMPUTERNAME': 'T-W864-IX-145', 08:10:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:10:44 INFO - 'DCLOCATION': 'SCL3', 08:10:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:10:44 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:10:44 INFO - 'HOMEDRIVE': 'C:', 08:10:44 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 08:10:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:10:44 INFO - 'KTS_VERSION': '1.19c', 08:10:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 08:10:44 INFO - 'LOGONSERVER': '\\\\T-W864-IX-145', 08:10:44 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:10:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:44 INFO - 'MOZ_NO_REMOTE': '1', 08:10:44 INFO - 'NO_EM_RESTART': '1', 08:10:44 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:10:44 INFO - 'OS': 'Windows_NT', 08:10:44 INFO - 'OURDRIVE': 'C:', 08:10:44 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', 08:10:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:10:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:10:44 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:10:44 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:10:44 INFO - 'PROCESSOR_LEVEL': '6', 08:10:44 INFO - 'PROCESSOR_REVISION': '1e05', 08:10:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:10:44 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:10:44 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:10:44 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:10:44 INFO - 'PROMPT': '$P$G', 08:10:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:10:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:10:44 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:10:44 INFO - 'PWD': 'C:\\slave\\test', 08:10:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:10:44 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:10:44 INFO - 'SYSTEMDRIVE': 'C:', 08:10:44 INFO - 'SYSTEMROOT': 'C:\\windows', 08:10:44 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:44 INFO - 'TEST1': 'testie', 08:10:44 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:44 INFO - 'USERDOMAIN': 'T-W864-IX-145', 08:10:44 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 08:10:44 INFO - 'USERNAME': 'cltbld', 08:10:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-145', 08:10:44 INFO - 'WINDIR': 'C:\\windows', 08:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 08:10:44 INFO - Cleaning up... 08:10:44 INFO - Return code: 0 08:10:44 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 08:10:44 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')]} 08:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:44 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')]} 08:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:44 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 0x022DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028243E0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02338E90>, '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 0x01D5A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02864520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-145', 'USERDOMAIN': 'T-W864-IX-145', '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-145', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-145', '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-145\\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 08:10:44 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 08:10:44 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 08:10:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:10:44 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Roaming', 08:10:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:10:44 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:10:44 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:10:44 INFO - 'COMPUTERNAME': 'T-W864-IX-145', 08:10:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:10:44 INFO - 'DCLOCATION': 'SCL3', 08:10:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:10:44 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:10:44 INFO - 'HOMEDRIVE': 'C:', 08:10:44 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 08:10:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:10:44 INFO - 'KTS_VERSION': '1.19c', 08:10:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 08:10:44 INFO - 'LOGONSERVER': '\\\\T-W864-IX-145', 08:10:44 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:10:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:44 INFO - 'MOZ_NO_REMOTE': '1', 08:10:44 INFO - 'NO_EM_RESTART': '1', 08:10:44 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:10:44 INFO - 'OS': 'Windows_NT', 08:10:44 INFO - 'OURDRIVE': 'C:', 08:10:44 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', 08:10:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:10:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:10:44 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:10:44 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:10:44 INFO - 'PROCESSOR_LEVEL': '6', 08:10:44 INFO - 'PROCESSOR_REVISION': '1e05', 08:10:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:10:44 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:10:44 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:10:44 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:10:44 INFO - 'PROMPT': '$P$G', 08:10:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:10:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:10:44 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:10:44 INFO - 'PWD': 'C:\\slave\\test', 08:10:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:10:44 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:10:44 INFO - 'SYSTEMDRIVE': 'C:', 08:10:44 INFO - 'SYSTEMROOT': 'C:\\windows', 08:10:44 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:44 INFO - 'TEST1': 'testie', 08:10:44 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:44 INFO - 'USERDOMAIN': 'T-W864-IX-145', 08:10:44 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 08:10:44 INFO - 'USERNAME': 'cltbld', 08:10:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-145', 08:10:44 INFO - 'WINDIR': 'C:\\windows', 08:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:45 INFO - Downloading blobuploader-1.2.4.tar.gz 08:10:45 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 08:10:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:46 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 08:10:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:46 INFO - Downloading docopt-0.6.1.tar.gz 08:10:46 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 08:10:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:10:46 INFO - Running setup.py install for blobuploader 08:10:46 INFO - Running setup.py install for requests 08:10:47 INFO - Running setup.py install for docopt 08:10:47 INFO - Successfully installed blobuploader requests docopt 08:10:47 INFO - Cleaning up... 08:10:48 INFO - Return code: 0 08:10:48 INFO - Installing None into virtualenv C:\slave\test\build/venv 08:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:48 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 0x022DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028243E0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02338E90>, '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 0x01D5A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02864520>, '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-145', 'USERDOMAIN': 'T-W864-IX-145', '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-145', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-145', '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-145\\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 08:10:48 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 08:10:48 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 08:10:48 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:10:48 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Roaming', 08:10:48 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:10:48 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:10:48 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:10:48 INFO - 'COMPUTERNAME': 'T-W864-IX-145', 08:10:48 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:10:48 INFO - 'DCLOCATION': 'SCL3', 08:10:48 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:10:48 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:10:48 INFO - 'HOMEDRIVE': 'C:', 08:10:48 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 08:10:48 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:10:48 INFO - 'KTS_VERSION': '1.19c', 08:10:48 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 08:10:48 INFO - 'LOGONSERVER': '\\\\T-W864-IX-145', 08:10:48 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:10:48 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:48 INFO - 'MOZ_NO_REMOTE': '1', 08:10:48 INFO - 'NO_EM_RESTART': '1', 08:10:48 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:10:48 INFO - 'OS': 'Windows_NT', 08:10:48 INFO - 'OURDRIVE': 'C:', 08:10:48 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:10:48 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:10:48 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:10:48 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:10:48 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:10:48 INFO - 'PROCESSOR_LEVEL': '6', 08:10:48 INFO - 'PROCESSOR_REVISION': '1e05', 08:10:48 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:10:48 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:10:48 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:10:48 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:10:48 INFO - 'PROMPT': '$P$G', 08:10:48 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:10:48 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:10:48 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:10:48 INFO - 'PWD': 'C:\\slave\\test', 08:10:48 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:10:48 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:10:48 INFO - 'SYSTEMDRIVE': 'C:', 08:10:48 INFO - 'SYSTEMROOT': 'C:\\windows', 08:10:48 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:48 INFO - 'TEST1': 'testie', 08:10:48 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:10:48 INFO - 'USERDOMAIN': 'T-W864-IX-145', 08:10:48 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 08:10:48 INFO - 'USERNAME': 'cltbld', 08:10:48 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-145', 08:10:48 INFO - 'WINDIR': 'C:\\windows', 08:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 08:10:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7ep78i-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 08:10:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 08:10:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7ogoma-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 08:10:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 08:10:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kpaa3e-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 08:10:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 08:10:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-q4eoi4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 08:10:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 08:10:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hbqj5c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 08:10:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 08:10:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7di1_4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 08:10:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 08:10:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0nstw0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 08:10:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 08:10:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0qdju4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 08:10:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 08:10:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pqfatd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 08:10:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 08:10:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vavlvs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 08:10:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 08:10:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-m9r5zk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 08:10:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 08:10:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8ka8gn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 08:10:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 08:10:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ai6bu2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 08:10:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 08:10:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ai50bk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 08:10:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 08:10:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5nj8wx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 08:10:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 08:10:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-b4pncd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 08:10:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 08:10:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5ainlz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 08:10:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:10:50 INFO - Running setup.py install for manifestparser 08:10:51 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 08:10:51 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 08:10:51 INFO - Running setup.py install for mozcrash 08:10:52 INFO - Running setup.py install for mozdebug 08:10:52 INFO - Running setup.py install for mozdevice 08:10:52 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 08:10:52 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 08:10:52 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 08:10:52 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 08:10:53 INFO - Running setup.py install for mozfile 08:10:53 INFO - Running setup.py install for mozhttpd 08:10:53 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 08:10:53 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 08:10:53 INFO - Running setup.py install for mozinfo 08:10:54 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 08:10:54 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 08:10:54 INFO - Running setup.py install for mozInstall 08:10:54 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 08:10:54 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 08:10:54 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 08:10:54 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 08:10:54 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 08:10:54 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 08:10:54 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 08:10:54 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 08:10:54 INFO - Running setup.py install for mozleak 08:10:55 INFO - Running setup.py install for mozlog 08:10:55 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 08:10:55 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 08:10:55 INFO - Running setup.py install for moznetwork 08:10:56 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 08:10:56 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 08:10:56 INFO - Running setup.py install for mozprocess 08:10:57 INFO - Running setup.py install for mozprofile 08:10:57 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 08:10:57 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 08:10:57 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 08:10:57 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 08:10:57 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 08:10:57 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 08:10:57 INFO - Running setup.py install for mozrunner 08:10:58 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 08:10:58 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 08:10:58 INFO - Running setup.py install for mozscreenshot 08:10:59 INFO - Running setup.py install for moztest 08:10:59 INFO - Running setup.py install for mozversion 08:10:59 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 08:10:59 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 08:10:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:10:59 INFO - Cleaning up... 08:10:59 INFO - Return code: 0 08:10:59 INFO - Installing None into virtualenv C:\slave\test\build/venv 08:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:59 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 0x022DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028243E0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02338E90>, '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 0x01D5A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02864520>, '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-145', 'USERDOMAIN': 'T-W864-IX-145', '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-145', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-145', '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-145\\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 08:10:59 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 08:10:59 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 08:10:59 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:10:59 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Roaming', 08:10:59 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:10:59 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:10:59 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:10:59 INFO - 'COMPUTERNAME': 'T-W864-IX-145', 08:10:59 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:10:59 INFO - 'DCLOCATION': 'SCL3', 08:10:59 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:10:59 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:10:59 INFO - 'HOMEDRIVE': 'C:', 08:10:59 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 08:10:59 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:10:59 INFO - 'KTS_VERSION': '1.19c', 08:10:59 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 08:10:59 INFO - 'LOGONSERVER': '\\\\T-W864-IX-145', 08:10:59 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:10:59 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:59 INFO - 'MOZ_NO_REMOTE': '1', 08:10:59 INFO - 'NO_EM_RESTART': '1', 08:10:59 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:10:59 INFO - 'OS': 'Windows_NT', 08:10:59 INFO - 'OURDRIVE': 'C:', 08:10:59 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', 08:10:59 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:10:59 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:10:59 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:10:59 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:10:59 INFO - 'PROCESSOR_LEVEL': '6', 08:10:59 INFO - 'PROCESSOR_REVISION': '1e05', 08:10:59 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:10:59 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:10:59 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:10:59 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:10:59 INFO - 'PROMPT': '$P$G', 08:10:59 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:10:59 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:10:59 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:10:59 INFO - 'PWD': 'C:\\slave\\test', 08:10:59 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:10:59 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:10:59 INFO - 'SYSTEMDRIVE': 'C:', 08:10:59 INFO - 'SYSTEMROOT': 'C:\\windows', 08:10:59 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:11:00 INFO - 'TEST1': 'testie', 08:11:00 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:11:00 INFO - 'USERDOMAIN': 'T-W864-IX-145', 08:11:00 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 08:11:00 INFO - 'USERNAME': 'cltbld', 08:11:00 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-145', 08:11:00 INFO - 'WINDIR': 'C:\\windows', 08:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 08:11:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uhlnrr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 08:11:00 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)) 08:11:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 08:11:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xnnu6u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 08:11:00 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)) 08:11:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 08:11:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-h_iyut-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 08:11:00 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)) 08:11:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 08:11:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zpjrhs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 08:11:00 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)) 08:11:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 08:11:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-c1xdnb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 08:11:00 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)) 08:11:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 08:11:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cqu786-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 08:11:01 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)) 08:11:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 08:11:01 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3fflox-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 08:11:01 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)) 08:11:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 08:11:01 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5rm_zj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 08:11:01 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)) 08:11:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 08:11:01 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-neeimy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 08:11:01 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)) 08:11:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 08:11:01 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uvkbns-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 08:11:01 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)) 08:11:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 08:11:01 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uzr60l-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 08:11:01 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)) 08:11:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 08:11:01 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-srlkks-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 08:11:01 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)) 08:11:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 08:11:01 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zacruu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 08:11:01 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)) 08:11:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 08:11:01 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-w0ac0t-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 08:11:02 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)) 08:11:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 08:11:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dabsgm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 08:11:02 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)) 08:11:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 08:11:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wanwhs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 08:11:02 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)) 08:11:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 08:11:02 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-whqocu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 08:11:02 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)) 08:11:02 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)) 08:11:02 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)) 08:11:02 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)) 08:11:02 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)) 08:11:02 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)) 08:11:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 08:11:02 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 08:11:02 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 08:11:03 INFO - Downloading blessings-1.6.tar.gz 08:11:03 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 08:11:03 INFO - Installing collected packages: blessings 08:11:03 INFO - Running setup.py install for blessings 08:11:04 INFO - Successfully installed blessings 08:11:04 INFO - Cleaning up... 08:11:07 INFO - Return code: 0 08:11:07 INFO - Done creating virtualenv C:\slave\test\build/venv. 08:11:07 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 08:11:07 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 08:11:07 INFO - Reading from file tmpfile_stdout 08:11:07 INFO - Using _rmtree_windows ... 08:11:07 INFO - Using _rmtree_windows ... 08:11:07 INFO - Current package versions: 08:11:07 INFO - blessings == 1.6 08:11:07 INFO - blobuploader == 1.2.4 08:11:07 INFO - docopt == 0.6.1 08:11:07 INFO - functools32 == 3.2.3-2 08:11:07 INFO - jsonschema == 2.5.1 08:11:07 INFO - manifestparser == 1.1 08:11:07 INFO - mozInstall == 1.12 08:11:07 INFO - mozcrash == 0.17 08:11:07 INFO - mozdebug == 0.1 08:11:07 INFO - mozdevice == 0.48 08:11:07 INFO - mozfile == 1.2 08:11:07 INFO - mozhttpd == 0.7 08:11:07 INFO - mozinfo == 0.9 08:11:07 INFO - mozleak == 0.1 08:11:07 INFO - mozlog == 3.4 08:11:07 INFO - moznetwork == 0.27 08:11:07 INFO - mozprocess == 0.23 08:11:07 INFO - mozprofile == 0.28 08:11:07 INFO - mozrunner == 6.12 08:11:07 INFO - mozscreenshot == 0.1 08:11:07 INFO - mozsystemmonitor == 0.3 08:11:07 INFO - moztest == 0.7 08:11:07 INFO - mozversion == 1.4 08:11:07 INFO - psutil == 3.1.1 08:11:07 INFO - requests == 1.2.3 08:11:07 INFO - Installing None into virtualenv C:\slave\test\build/venv 08:11:07 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')]} 08:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:07 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')]} 08:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:07 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 0x022DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028243E0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02338E90>, '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 0x01D5A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02864520>, '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-145', 'USERDOMAIN': 'T-W864-IX-145', '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-145', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-145', '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-145\\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 08:11:07 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 08:11:07 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 08:11:07 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:11:07 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Roaming', 08:11:07 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:11:07 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:11:07 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:11:07 INFO - 'COMPUTERNAME': 'T-W864-IX-145', 08:11:07 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:11:07 INFO - 'DCLOCATION': 'SCL3', 08:11:07 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:11:07 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:11:07 INFO - 'HOMEDRIVE': 'C:', 08:11:07 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 08:11:07 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:11:07 INFO - 'KTS_VERSION': '1.19c', 08:11:07 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 08:11:07 INFO - 'LOGONSERVER': '\\\\T-W864-IX-145', 08:11:07 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:11:07 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:07 INFO - 'MOZ_NO_REMOTE': '1', 08:11:07 INFO - 'NO_EM_RESTART': '1', 08:11:07 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:11:07 INFO - 'OS': 'Windows_NT', 08:11:07 INFO - 'OURDRIVE': 'C:', 08:11:07 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', 08:11:07 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:11:07 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:11:07 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:11:07 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:11:07 INFO - 'PROCESSOR_LEVEL': '6', 08:11:07 INFO - 'PROCESSOR_REVISION': '1e05', 08:11:07 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:11:07 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:11:07 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:11:07 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:11:07 INFO - 'PROMPT': '$P$G', 08:11:07 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:11:07 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:11:07 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:11:07 INFO - 'PWD': 'C:\\slave\\test', 08:11:07 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:11:07 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:11:07 INFO - 'SYSTEMDRIVE': 'C:', 08:11:07 INFO - 'SYSTEMROOT': 'C:\\windows', 08:11:07 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:11:07 INFO - 'TEST1': 'testie', 08:11:07 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:11:07 INFO - 'USERDOMAIN': 'T-W864-IX-145', 08:11:07 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 08:11:07 INFO - 'USERNAME': 'cltbld', 08:11:07 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-145', 08:11:07 INFO - 'WINDIR': 'C:\\windows', 08:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:07 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)) 08:11:07 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)) 08:11:07 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)) 08:11:07 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)) 08:11:07 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)) 08:11:07 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)) 08:11:07 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)) 08:11:07 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)) 08:11:07 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)) 08:11:07 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)) 08:11:07 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)) 08:11:07 INFO - Cleaning up... 08:11:07 INFO - Return code: 0 08:11:07 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 08:11:07 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')]} 08:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:07 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')]} 08:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:07 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 0x022DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028243E0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02338E90>, '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 0x01D5A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02864520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-145', 'USERDOMAIN': 'T-W864-IX-145', '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-145', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-145', '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-145\\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 08:11:07 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 08:11:07 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 08:11:07 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:11:07 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Roaming', 08:11:07 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:11:07 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:11:07 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:11:07 INFO - 'COMPUTERNAME': 'T-W864-IX-145', 08:11:07 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:11:07 INFO - 'DCLOCATION': 'SCL3', 08:11:07 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:11:07 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:11:07 INFO - 'HOMEDRIVE': 'C:', 08:11:07 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 08:11:07 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:11:07 INFO - 'KTS_VERSION': '1.19c', 08:11:07 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 08:11:07 INFO - 'LOGONSERVER': '\\\\T-W864-IX-145', 08:11:07 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:11:07 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:07 INFO - 'MOZ_NO_REMOTE': '1', 08:11:07 INFO - 'NO_EM_RESTART': '1', 08:11:07 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:11:07 INFO - 'OS': 'Windows_NT', 08:11:07 INFO - 'OURDRIVE': 'C:', 08:11:07 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', 08:11:07 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:11:07 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:11:07 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:11:07 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:11:07 INFO - 'PROCESSOR_LEVEL': '6', 08:11:07 INFO - 'PROCESSOR_REVISION': '1e05', 08:11:07 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:11:07 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:11:07 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:11:07 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:11:07 INFO - 'PROMPT': '$P$G', 08:11:07 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:11:07 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:11:07 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:11:07 INFO - 'PWD': 'C:\\slave\\test', 08:11:07 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:11:07 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:11:07 INFO - 'SYSTEMDRIVE': 'C:', 08:11:07 INFO - 'SYSTEMROOT': 'C:\\windows', 08:11:07 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:11:07 INFO - 'TEST1': 'testie', 08:11:07 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:11:07 INFO - 'USERDOMAIN': 'T-W864-IX-145', 08:11:07 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 08:11:07 INFO - 'USERNAME': 'cltbld', 08:11:07 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-145', 08:11:07 INFO - 'WINDIR': 'C:\\windows', 08:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 08:11:08 INFO - Cleaning up... 08:11:08 INFO - Return code: 0 08:11:08 INFO - Running post-action listener: _resource_record_post_action 08:11:08 INFO - Running post-action listener: _start_resource_monitoring 08:11:08 INFO - Starting resource monitoring. 08:11:08 INFO - [mozharness: 2016-10-18 15:11:08.224000Z] Finished create-virtualenv step (success) 08:11:08 INFO - [mozharness: 2016-10-18 15:11:08.224000Z] Running install step. 08:11:08 INFO - Running pre-action listener: _resource_record_pre_action 08:11:08 INFO - Running main action method: install 08:11:08 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 08:11:08 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 08:11:08 INFO - Reading from file tmpfile_stdout 08:11:08 INFO - Using _rmtree_windows ... 08:11:08 INFO - Using _rmtree_windows ... 08:11:08 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:08 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 08:11:08 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 08:11:08 INFO - Reading from file tmpfile_stdout 08:11:08 INFO - Output received: 08:11:08 INFO - Usage: mozinstall-script.py [options] installer 08:11:08 INFO - Options: 08:11:08 INFO - -h, --help show this help message and exit 08:11:08 INFO - -d DEST, --destination=DEST 08:11:08 INFO - Directory to install application into. [default: 08:11:08 INFO - "C:\slave\test"] 08:11:08 INFO - --app=APP Application being installed. [default: firefox] 08:11:08 INFO - Using _rmtree_windows ... 08:11:08 INFO - Using _rmtree_windows ... 08:11:08 INFO - mkdir: C:\slave\test\build\application 08:11:08 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'] 08:11:08 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 08:11:10 INFO - Reading from file tmpfile_stdout 08:11:10 INFO - Output received: 08:11:10 INFO - C:\slave\test\build\application\firefox\firefox.exe 08:11:10 INFO - Using _rmtree_windows ... 08:11:10 INFO - Using _rmtree_windows ... 08:11:10 INFO - Running post-action listener: _resource_record_post_action 08:11:10 INFO - [mozharness: 2016-10-18 15:11:10.851000Z] Finished install step (success) 08:11:10 INFO - [mozharness: 2016-10-18 15:11:10.851000Z] Running run-tests step. 08:11:10 INFO - Running pre-action listener: _resource_record_pre_action 08:11:10 INFO - Running main action method: run_tests 08:11:10 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 08:11:10 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 08:11:10 INFO - Python 2.7.3 08:11:10 INFO - Return code: 0 08:11:10 INFO - grabbing minidump binary from tooltool 08:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} ProcessManager NOT managing child processes 08:11:10 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 0x02338E90>, '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 0x01D5A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02864520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 08:11:10 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 08:11:10 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 08:11:10 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 08:11:10 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 08:11:11 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpj3ts0z 08:11:11 INFO - INFO - File integrity verified, renaming tmpj3ts0z to win32-minidump_stackwalk.exe 08:11:11 INFO - Return code: 0 08:11:11 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 08:11:11 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 08:11:11 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 08:11:11 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 08:11:11 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 08:11:11 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/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-145', '--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 08:11:11 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/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-145 --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 08:11:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:11:11 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Roaming', 08:11:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:11:11 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:11:11 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:11:11 INFO - 'COMPUTERNAME': 'T-W864-IX-145', 08:11:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:11:11 INFO - 'DCLOCATION': 'SCL3', 08:11:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:11:11 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:11:11 INFO - 'HOMEDRIVE': 'C:', 08:11:11 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-145', 08:11:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:11:11 INFO - 'KTS_VERSION': '1.19c', 08:11:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-145\\AppData\\Local', 08:11:11 INFO - 'LOGONSERVER': '\\\\T-W864-IX-145', 08:11:11 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 08:11:11 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 08:11:11 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:11:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:11 INFO - 'MOZ_NO_REMOTE': '1', 08:11:11 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 08:11:11 INFO - 'NO_EM_RESTART': '1', 08:11:11 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:11:11 INFO - 'OS': 'Windows_NT', 08:11:11 INFO - 'OURDRIVE': 'C:', 08:11:11 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:11:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:11:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:11:11 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:11:11 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:11:11 INFO - 'PROCESSOR_LEVEL': '6', 08:11:11 INFO - 'PROCESSOR_REVISION': '1e05', 08:11:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:11:11 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:11:11 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:11:11 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:11:11 INFO - 'PROMPT': '$P$G', 08:11:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:11:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:11:11 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:11:11 INFO - 'PWD': 'C:\\slave\\test', 08:11:11 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 08:11:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:11:11 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:11:11 INFO - 'SYSTEMDRIVE': 'C:', 08:11:11 INFO - 'SYSTEMROOT': 'C:\\windows', 08:11:11 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:11:11 INFO - 'TEST1': 'testie', 08:11:11 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:11:11 INFO - 'USERDOMAIN': 'T-W864-IX-145', 08:11:11 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-145', 08:11:11 INFO - 'USERNAME': 'cltbld', 08:11:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-145', 08:11:11 INFO - 'WINDIR': 'C:\\windows', 08:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:11:11 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/I0zstixqSQ62mDVcVImycw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-145', '--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 08:11:12 INFO - mozversion application_buildid: 20161018043003 08:11:12 INFO - mozversion application_changeset: dc89484d4b45abf442162e5ea2dd46f9de40197d 08:11:12 INFO - mozversion application_display_name: Nightly 08:11:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:12 INFO - mozversion application_name: Firefox 08:11:12 INFO - mozversion application_remotingname: firefox 08:11:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:11:12 INFO - mozversion application_vendor: Mozilla 08:11:12 INFO - mozversion application_version: 52.0a1 08:11:12 INFO - mozversion platform_buildid: 20161018043003 08:11:12 INFO - mozversion platform_changeset: dc89484d4b45abf442162e5ea2dd46f9de40197d 08:11:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:11:12 INFO - mozversion platform_version: 52.0a1 08:11:12 INFO - using testdate: 1476803472 08:11:12 INFO - actual date: 1476803472 08:11:12 INFO - starting webserver on 'localhost:49237' 08:11:12 INFO - SUITE-START | Running 2 tests 08:11:12 INFO - TEST-START | dromaeo_css 08:11:12 INFO - operating with platform_type : w8_ 08:11:12 INFO - Initialising browser for dromaeo_css test... 08:11:12 INFO - TEST-INFO | started process 4184 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbxaw4o\profile http://localhost:49237/getInfo.html) 08:11:21 INFO - PROCESS | 4184 | __metrics Screen width/height:1600/1200 08:11:21 INFO - PROCESS | 4184 | colorDepth:24 08:11:21 INFO - PROCESS | 4184 | Browser inner width/height: 1010/674 08:11:21 INFO - PROCESS | 4184 | __metrics 08:11:22 INFO - PROCESS | 4184 | 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" 08:11:22 INFO - PROCESS | 4184 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:11:23 INFO - TEST-INFO | 4184: exit 0 08:11:23 INFO - Browser initialized. 08:11:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:11:23 INFO - TEST-INFO | started process 3736 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbxaw4o\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:24 INFO - PROCESS | 3736 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 08:11:35 INFO - PROCESS | 3736 | RSS: Main: 160309248 08:11:35 INFO - PROCESS | 3736 | 08:12:26 INFO - PROCESS | 3736 | 1476803546328 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] 08:14:38 INFO - PROCESS | 3736 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 08:14:40 INFO - PROCESS | 3736 | RSS: Main: 235114496 08:14:40 INFO - PROCESS | 3736 | 08:17:42 INFO - PROCESS | 3736 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 08:17:43 INFO - PROCESS | 3736 | RSS: Main: 230862848 08:17:43 INFO - PROCESS | 3736 | 08:20:45 INFO - PROCESS | 3736 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 08:20:46 INFO - PROCESS | 3736 | RSS: Main: 179884032 08:20:46 INFO - PROCESS | 3736 | 08:23:48 INFO - PROCESS | 3736 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 08:23:48 INFO - PROCESS | 3736 | RSS: Main: 174694400 08:23:48 INFO - PROCESS | 3736 | 08:26:52 INFO - PROCESS | 3736 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 08:26:52 INFO - PROCESS | 3736 | RSS: Main: 167997440 08:26:52 INFO - PROCESS | 3736 | 08:29:55 INFO - PROCESS | 3736 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 08:29:55 INFO - PROCESS | 3736 | RSS: Main: 210300928 08:29:55 INFO - PROCESS | 3736 | 08:29:55 INFO - PROCESS | 3736 | __start_tp_report 08:29:55 INFO - PROCESS | 3736 | _x_x_mozilla_page_load 08:29:55 INFO - PROCESS | 3736 | _x_x_mozilla_page_load_details 08:29:55 INFO - PROCESS | 3736 | |i|pagename|runs| 08:29:55 INFO - PROCESS | 3736 | |0;dojo.html;2882.8702708378123;2900.202444327811;2919.5182794838847;2939.485590021746;2944.8969286074994;5169.3021442105355;5172.534471897528;5184.092783762845;5191;5279.524842764151;5169.069567477862;5194.480551944804;5218.686878787266;5231.2937753403185;5252.921206181911;4726.598239149676;4726.881827954311;4733.621310295168;4784.5933095686905;4791.688540244891;4775.617950563964;4807.134715751164;4807.975960120195;4820.951790482103;4827.324174615556;3236.8381580920977;4662.673612847102;4719.126961512114;4791.4250289965075;4805.711657300556;4522.547745225484;4691.90616187676;4759.976200119012;4766.73782941938;4806.182948898696;4624.630029597624;4662.207424737802;4685.648576356787;4706.835260765891;4728.929066064012;5125.589952803767;5130.948690513084;5165.948340516585;5181.4300426953005;5227.163653815372;5527.723613819333;5543.556515478752;5604.663720176803;5621.988042152411;5626.859328516779;5481.506664400184;5658.74535645897;5660.405657405954;5667.943320566783;5719.742611582447;5079;5081.872953176163;5100.030994111107;5120.02719483297;5131.743412829381;5667.858303542362;5703.230063941398;5705.429457054344;5707.857303567444;5714.200011998323;5385.919211211835;5436.075867102602;5436.891262174734;5442.510174084351;5444.972775136178;5539.030669632798;5588.552915766729;5588.86027849307;5588.944110558842;5596.636218645775;5440.202648795271;5549.112142057332;5562.471565201299;5564.137558678412;5564.805231816867;5408.756605952742;5450.454954504517;5451.127819548853;5472.671639701631;5480.588955828329;3732.5520937487677;3760.304343696425;3775.7356985011334;3821.102041020358;3831.885043448701;3283.589551306087;3300.2409445827593;3301.7853839500835;3301.9339613207603;3356.681115294043;5362.490563396471;5435.048866448435;5438.972805135949;5442.482964118402;5450.454954504517;5600.663960162403;5635.830925072254;5642.0972644377525;5647.29408823897;5649.152627105967;5413.160960051198;5443.292371991695;5447.346318441812;5451.945480545223;5454.372747134131;4527.592516673515;4529.456465224194;4533.252013417749;4533.297338912474;4534.478534968455;5833.591648584643;5853.385394533598;5855.912161317498;5861.824145275648;5862.413758624189;5638.661680299195;5653.123765816305;5736.082226843685;5737.397573254915;5746.195532625519;5856.297244330707;5880.735366908585;5881.735321910439;5883.176355310175;5889.057750759858;5371.355437347544;5574.581906357121;5578.079616863172;5578.497935185853;5600.047991841316;5597.748101335531;5638.915416268677;5669.433056694297;5670.319561652628;5670.688112153706;5511.255980442749;5538.944610553843;5540.445955404427;5558.944410555842;5572.637778544382;5459.918101228405;5494.011078005838;5511.889762204813;5513.696746678971;5531.7234138293725;5358.758855851418;5368.7047212403695;5382.977234325465;5465.098258787256;5530.976769297693;5503.11950087984;5509.393966663744;5539.861503462445;5541.612087153861;5596.580256480862;5401;5478.561715062865;5485.890282194254;5493.395726470005;5495.488740596368 08:29:55 INFO - PROCESS | 3736 | |1;ext.html;553.139867506028;570.7460180219801;580.9273840769904;585.1632166002615;594.7739858853635;29174.85412572937;30765.38469230617;31844.52233216501;31852.840735796348;31864.203394915137;38156.427653585146;39225.803870980606;39375;42726.572734272726;42786.786066069624;8373.623186956587;8447.746567602982;8486.830263394728;8509;8509;7610.771676849703;8501.65993360268;8538.87191692125;8573.828523429527;8574.914250857473;7563.016807815004;9813.558389872473;9985.950070249675;10060.54727537259;10319.122874555671;10055.296129270953;10079.34484258521;10115.747106322327;10124.848127278097;10141.087302142843;7542.62286885659;10060;10119.898801012043;10129.645462408855;10130.341527800743;28641.427171456453;30506.389872202653;30601.081967540787;36076.45885311723;39233.80383098095;3124.421981933327;3226.548283240348;3274.345130973815;3724.7951362675044;3851.5185601799776;29326.413471730444;29727;29766.404671906657;30122;31071.533926991113;3508.561429821272;3709.332320182366;3724.050367156358;3729.8321575529167;3816.0459885028745;291275;293499;294757;294904.99999999785;295509;44090.33864492035;51013.23480147801;51493.227601586004;51535.969280614176;51545;45995;51871.74064129655;53061.734691326295;53347.19979200315;57450.712746436;13997.230152341515;14141.929290353688;14167.433302667983;14185.929070354583;14186.574402767934;11545.191836571359;11732.237404568676;11780.823287650692;11785.528578856922;11790;14740.484083057256;15620.609484762972;16524.173791310386;16576.088315142784;16653;6083.7870674526175;6323.778667746698;6373;6485.221773387224;6512.446442052384;774.6204359863626;854.8502264454299;868.3877866104381;896.3814967672415;913.7624217703445;27638.045677941587;28017.859910700317;28099.719002810118;28244.022918395516;28334.433311333658;911.7902882336967;929.6002718830832;942.8255772682076;962.4754508792724;974.5955428497094;14454.277286135652;14616.488422905148;14673.192974386298;14865.925670371578;15036.097834129987;458656;462827;463050;463514;463538;48597.75701121543;48706;49121.263181052316;49159.26261106086;49167.26249106266;1121.220751577662;1156.9305841649527;1163.0985985860686;1166.9241499302518;1169.9941500292614;26430.471390572464;27119.1864244073;27315.86342068277;27488.03791867275;27655.58516622212;43302.35046474243;43613.78193109014;43667.56332436635;43690;43704.781476092416;295508;360377;361774;362486;363034;22142.114315427203;22938.885305573367;23830.404239894142;24996.37509062288;25398.49203015966;40141.79929100453;40260;40445.797771010955;41407;41487.58512414837;35371.29257414786;35790.4631430534;35928.64071359253;36231.818840905624;36235.45646815247;35368.29263414666;35820.462693059104;35823;36102.4584631236;36265;34390.48414273838;34440.13899652529;35002.64997349994;35028.64971350356;35086;31281.374372511968;32381.838090809397;32525;32583;32749;23093.769062309162;23542.646860297453;23813.404664883517;23914.521709565364;23939.521209576058 08:29:55 INFO - PROCESS | 3736 | |2;jquery.html;332.5062282510473;345.90141809584276;352.2620110867732;353.40627745387746;374.30753106752513;16138.83861161388;16842;18161.273549058023;18283.634327313444;18327.17527711253;16205;16470.34118635256;16805.91597042013;16955.152242387892;17089.23098460572;5103.923441148377;5359.705216213107;5370.113931201347;5373.596980226479;5375.596830237729;3957;4148.605882441163;5229.947700523003;5682.374938756733;5877;5918.911216331759;5963.9403605964035;5964.642121472704;5972.79095231667;5976.88046239075;5756.366799652035;5940.2871655401195;5990.730417131218;5991.580589358747;6000.33996260411;4676.392069031038;5238.292830467914;5241.056609810233;5245.921311180336;5270.262163297141;11634.360110193937;13480;19550.608987820164;20170.79829201704;20191.394258172277;1889.4142815727032;1995.34153729269;1999.9400017999483;2049.405672355015;2710.7966902482394;8634.136586341378;8680.8697869532;8689.869651955225;8979.865302020475;9097;1787.7944036435847;1793.4978206102312;1814.564504518906;1839.2091400697695;1863;68128.6593567034;75315.6234218831;77435;78201.82697259603;78422.21577784207;8244.422890397735;8808.339374546935;8914.86627700585;9884.209263258923;10219.693409197736;11458.828117578243;11610.76778464426;11625.418729063513;11625.59310424131;11636.243644163102;6906.620135892575;7171.462140339496;7197.964010179916;7221.31397517235;7239.9276007240305;7136;7194.964025179946;7289.781306560812;7353.1911489736085;7466.775996719998;3552.3073000764603;3598.442241452579;3620.4388319809946;3641.1807343348064;3674.375356189454;1603.2945503978212;1697.6265221651217;1710.863130949521;1733.1854028606535;1784.5627821183894;773.4083426178978;774.4462709162863;787.9566623835744;861.5132450165636;917.9449233046039;16110.355585776671;16790.24443900003;16937.32250709958;17002;17105;783.5572901310856;797.948133371329;823.333100188837;837.4723923927886;880.4013270975798;9087.909120908706;9384.5307734613;9470.14768670823;9478.099580539838;9553.761155971157;387539.0621100027;389635;389855;390858;390899;73044.98252596051;73934;74159.35928329283;74692.62653686806;78632;825.5170725125869;862.5859587398085;876.8421684096796;877.9736607901773;878.2008372381102;12995.545155919497;15429.151396673291;15501.224938753243;15663.608409789846;15882.444114455939;35910;35965;35983.460248096824;36436;36616.45075323925;48797.512024880714;48922.75538622284;48969.75515122402;49710.25434618411;50030.49969500404;6359.650219237987;6447.4197322241225;7592.088949326117;7594.620268986418;7801.141874393926;9476.336656433983;11466.426678666201;11895.643130705746;11978.700532486757;12118.818217726564;9524.190044299632;9566.13904748576;9701.805963880543;9787.755306117404;9892.653757118467;9341.299402544972;9599.664011759554;9644.228461723185;10044.648437304659;10199.337043092175;9773.609055637695;9864.950675246579;9950.502474876372;9964.352317099365;10546.103581195684;6813.2846051163915;6903.861922761617;6982.266861979419;6996.650167491707;7161.713531458683;8599.871001935102;9685;9728.221742260745;9792;10198 08:29:55 INFO - PROCESS | 3736 | |3;mootools.html;1225.5097960815672;1252.981205281921;1293.3727142335965;1488.9478868239614;1493.0444515510076;7214.134303883535;7702.460827742047;7721.845563088735;7722.729704460338;7724.536527808335;7002.579845209279;7227.16887557931;7507.924920750791;7535.434842386816;7717.498362606427;1979.3468155508647;2009.1461129020108;2009.2063634864219;2014.7582290125206;2016.0625309231204;1938.9515262118418;1954.882707037575;1957.2855907593769;1966.9803301967013;1973.2698901406427;1667.3330667732882;1772.2113659421564;1891.2718603337676;1949.2008276606593;1956.3641816409652;1961.6268611971677;1979.8317143042714;1981.6234915366106;1982.0387112250546;1982.3161009451717;1894.1949671389605;1904.2573396375424;1912.8565357598097;1918.9829390422958;1923.6248931458372;7752.186020467826;7840.314332418558;7870.134285228621;7949.125596184415;8104.270615644561;4545.11370282795;4648.256278995378;4658.091672123937;4662.393888794469;4667.136579732726;2856.157433557106;2924.1958461423064;2973.4053189362;2980.3145276586506;2985.4327677741376;914.9359544831865;922.7508572685338;926.6324540798257;940.9858852117223;941.3316545252878;10856.67429977094;10922.563097476092;10937.726556836144;10939;10941.726456838564;3861.691064714816;3937.8621748238675;3961.8613348532663;3962.7622342659533;4164.979175104105;8331.416800824005;8452.61963211657;8480.787980300542;8486.32109431244;8487.023992240847;4546.886327841764;4595.747233902101;4618.607418369409;4624.468186158568;4625.213713668684;4152.854650087233;4354.869353919387;4355.455568053993;4358.128374325148;4358.716683415568;3269.3297873935785;3307.3219989902013;3329.1344250495044;3345.397828390864;3368.764186506921;994.2990191914682;998.1116806042628;1001.6994901529512;1008.4907121903392;1013.7769690668041;764.1823249123385;764.7534518734539;781.7850091224958;786.8780339047457;794.1700922535964;4888.608911287089;4945.7774400152075;4948.727819969864;4998.525140111684;5133.024725302255;344.36636588676953;349.6311391482011;352.56106147846094;353.1947160474123;363.9053846000006;3239.4654881944684;3287.3589650018494;3334.7832390894514;3341.983290083534;3398.8470518826216;9561.235101191887;9760.170385517169;9774;9830.459324737209;9879.654212102541;9789.804203915883;9836.262280329003;9838.06538378853;9838.311318207656;9839.55721992512;7010.193827709777;7097.964510177416;7100.254473280334;7173.1392232932385;7397.630118494161;4919.950800491949;4953.851384458472;4960.330355402119;4989.101961646938;5035.118854200427;9011.909880901107;9071.50106744109;9113.817723645623;9164.495952722398;9173.77065573366;8730.388872779098;9097.226735727538;9117;9295.767605809639;9320.627174912928;6852.931470685229;6934.341237582422;6996.720131194696;7022.894656580053;7025.543339682904;7605.885911711218;7623.885641715489;7666.884996725165;7682.884756728542;7684.961575192088;5965.254343207099;6286.339934306832;6795.45636349081;6846.520743547904;6923.653817309014;6594.538382313192;6644.800655980328;6673.799786006428;6704.161979752531;6722.361375669304;5909.881802364014;5999.26021453791;6003.549733769897;6005.90991135142;6007.189029481139;4245.341971994346;4290.249206388807;4304.440422745149;4350.8477203299;4421.6683748719615;4332.415123958352;4355.216061109031;4380.299152135643;4405.669574781969;4405.7797110145 08:29:55 INFO - PROCESS | 3736 | |4;prototype.html;294.05461441465684;298.2528765442566;301.3746476062171;304.1954031586454;304.2606466286922;5262.394969534291;5268.499492548207;5310.73446327683;5323.89352212956;5339.839804805857;5083.517065878745;5122;5207.427183009866;5219.416388887496;5220.712860792655;3727.7017838572983;3828;3830.3296923038356;3844.6539811416965;3850.3261929162422;3530.223350862806;3874.535055793309;3877.37150396834;3879.8254078566533;3965.9206815863668;3907.902302442433;3921.1569512554797;3942;3948.447217389568;3958.129211573449;3929.351656976595;3974.284628766821;3974.3839704845504;3978.9853587335333;3980.562138164814;3233.579634647481;3365.713914317286;3414.2830005698834;3485.4249048907154;3525.94711079334;4970.925436118461;4989.351384320052;4992.775325110379;5043.243513472972;5083.720395378253;4584.862454126382;4586.931196032062;4588.770561471946;4607.516210797851;4665.136949664323;5226.92159617606;5279.102552566073;5332;5460.918086228709;5511.448855114497;3690.3172913010912;3717.832697528591;3725.2735716535285;3725.329440700673;3728.1611637381643;5305.4164041955355;5445.945540544544;5488.051741631743;5565.6104072714925;5618.269624948731;3947.921041579152;3948.230095131479;3957.782321972262;3958.7435161957983;3961.2275606256503;4014.4708833435334;4065.166640838621;4068.267711811843;4070.4708387909973;4079.4900637420324;4486.730796152241;4595.391612935446;4627.8611641650805;4638.698484598491;4668.229742092584;5353.785848566014;5365.168398898177;5372.462753724596;5376.1935709643085;5384.838454846361;1350.8784209421003;1367.8221831162084;1378.5795332423506;1381.4888491258298;1391.5825252424231;837.4472847920343;874.9893872577184;879.1691851200554;894.2801045158579;895.2479916869861;4695.81216751333;4708.728643266368;4726.409198850144;4741.004389078332;4753.691010084333;4863.975680121647;4880.145974454456;4913.410390753133;4993.176125939252;4998.575121114746;4750.287456881495;4777.163996300634;4840.443349014909;4876.926846097312;5070.780054665314;2955.9852200739288;2988.61148050752;2988.790784645054;2999.4151140527388;2999.4451026560155;5802.796902108406;5811.883762324815;5817.353104337516;5820;5843.5325173985975;5439.646422982493;5651.943480565224;5680.034394153004;5687.8862422752145;5711.543076553866;5687.573431992534;5771.538276937751;5772.913406298825;5787.479126878601;5797.826065218051;5362.678239305654;5534.39121696605;5614.803481878114;5627.324721033502;5648.435156484319;5458.153986131997;5480.424555421623;5483.287172667528;5486.396496385474;5498.505134537751;5538.113901775697;5711.714414279352;5713.9142912855505;5723.996601189717;5795.913061304;3644.7448678593305;3688.7233457491334;3720.6651401374006;3727.217284370204;3863.787491687984;5574.191742197278;5591.776328946797;5619.80330688424;5654.151877218285;5658.321001479849;5261.52646261823;5358.794271288929;5383.434739352469;5393.757280922289;5410.594205434687;5374.312843578211;5377.354717433933;5392.137258038695;5393.541548968382;5400.513953744182;5182.196759502283;5303.655262407931;5342.786288548415;5360.195970604441;5387.515123638891;5487.75002249076;5538.9169162461785;5550.556855217592;5557.666540007613;5562.2212890196215;5474.534664553557;5481.479259470344;5493.23094766725;5515.227868098389;5515.558755299647 08:29:55 INFO - PROCESS | 3736 | |5;yui.html;570.3070769015645;585.6369051188263;601.832311244631;693.2512886083027;729.3880969015872;12622.431990560424;13125.737485250289;13178.868211317884;13288.202707837512;13313.53402630907;13271;13304.866951330483;13387.93306033471;13459;13492.797608035888;560.4647561578682;637.6907200007981;652.0480099055385;654.613777871056;655.934406559345;569.9430056994308;642.2966851297822;656.2748163279555;658.4304576541281;663.9269680335159;694.1392673085388;694.8575542013875;695.9060526828864;697.4037198195521;697.7732237022963;590.503976659608;692.4806395203598;692.8614277144566;693.7259782385929;694.694334492824;441.6025576980711;444.1516703097069;444.508817756381;444.63095630626503;492.71422574906467;12981.805272920914;13689.452421903112;13713.314334283346;13717.314134293345;13719.039667223298;11825.290482570987;12005.279683219034;12236.632901012983;12313.815292770616;13064.54274100402;12122.39388030595;12144.574939877062;12154.696132596668;12232.694182645417;12550.058745594026;4181.1010632714115;4208.116295577933;4247.851325203634;4280.379344994958;4325.675574331937;71497.64251178764;71610;72276;73206.63396683036;74569;9460.385074970105;9461.195798357217;9491.240700743923;9492.525373731285;9526.523673816282;16279.10464924417;16419.261133248794;16578.419755308507;16579.917100414663;16635.085070321005;7515.887261691079;7574.621268936531;7608.619569021526;7751.186125456746;7787.06555213378;4021.3565829467143;4061.91876162481;4072.8778136655947;4149.170165966759;4204.264253755642;2980.210244285266;3127.108773999399;3132.5144602586633;3140.7487401007866;3229.1927018245437;577.5091172503422;584.8976429124887;593.8693487432757;594.111802854735;596.3827438601114;472.8605061506864;530.1967519208403;564.9661120150115;565.3187908570163;566.7931205110106;8931.598078086501;9118.361714679908;9122.407043542149;9156.130167634064;9178.128077832594;647.4787795824312;660.6135410784744;669.2203582825953;681.689831126846;686.5743239191634;4078.9184216315507;4085.5710150433774;4116.5060192777055;4120.649744771668;4171.10321280926;71586.64206678934;92591.0740892596;101755.4912225449;106879;107263;90763.15657953947;91189;92111.53944230235;94685.5265723667;95396;76282.85575716369;77315;77443;77544.61227693825;79609;7989.960050199712;8072.798180045545;8079.919200807916;8164.959175204323;8218.671253149807;44640.55359446364;44783;45290.547094528636;45450;45976.77011614921;60261.69869150626;64957;66772.66613666901;67198.66400667965;68869.65565172142;10249;10332.483375831329;10683.358998460117;10699.679009629723;10956.452177391258;12481.875181248071;12557.372131393577;12929.676758081123;12991.740165196454;13027.739445211233;11585.246958947642;11617.361045142261;11986.280823150639;12062.75874482488;12336.198147120409;11525.654230373102;11552.884471155181;11709.590164344207;11830.290182589073;12188.756224875275;10921.563137474412;11370.602028928948;11472.369019703996;11489.736129025967;11680.196752779442;9904.752381190528;9958.402495850272;10031.29780915329;10305.896941030494;10314;9892.307538472525;9952.303338766216;9974.451405172786;9983.251256155963;9989.60041598328 08:29:55 INFO - PROCESS | 3736 | __end_tp_report 08:29:55 INFO - PROCESS | 3736 | __start_cc_report 08:29:55 INFO - PROCESS | 3736 | _x_x_mozilla_cycle_collect,1359 08:29:55 INFO - PROCESS | 3736 | __end_cc_report 08:29:55 INFO - PROCESS | 3736 | __startTimestamp1476804595783__endTimestamp 08:29:55 INFO - PROCESS | 3736 | 08:29:55 INFO - PROCESS | 3736 | ------- Summary: start ------- 08:29:55 INFO - PROCESS | 3736 | Number of tests: 6 08:29:55 INFO - PROCESS | 3736 | 08:29:55 INFO - PROCESS | 3736 | [#0] dojo.html Cycles:165 Average:5155.85 Median:5444.97 stddev:702.88 (12.9%) stddev-sans-first:682.04 08:29:55 INFO - PROCESS | 3736 | Values: 2882.9 2900.2 2919.5 2939.5 2944.9 5169.3 5172.5 5184.1 5191.0 5279.5 5169.1 5194.5 5218.7 5231.3 5252.9 4726.6 4726.9 4733.6 4784.6 4791.7 4775.6 4807.1 4808.0 4821.0 4827.3 3236.8 4662.7 4719.1 4791.4 4805.7 4522.5 4691.9 4760.0 4766.7 4806.2 4624.6 4662.2 4685.6 4706.8 4728.9 5125.6 5130.9 5165.9 5181.4 5227.2 5527.7 5543.6 5604.7 5622.0 5626.9 5481.5 5658.7 5660.4 5667.9 5719.7 5079.0 5081.9 5100.0 5120.0 5131.7 5667.9 5703.2 5705.4 5707.9 5714.2 5385.9 5436.1 5436.9 5442.5 5445.0 5539.0 5588.6 5588.9 5588.9 5596.6 5440.2 5549.1 5562.5 5564.1 5564.8 5408.8 5450.5 5451.1 5472.7 5480.6 3732.6 3760.3 3775.7 3821.1 3831.9 3283.6 3300.2 3301.8 3301.9 3356.7 5362.5 5435.0 5439.0 5442.5 5450.5 5600.7 5635.8 5642.1 5647.3 5649.2 5413.2 5443.3 5447.3 5451.9 5454.4 4527.6 4529.5 4533.3 4533.3 4534.5 5833.6 5853.4 5855.9 5861.8 5862.4 5638.7 5653.1 5736.1 5737.4 5746.2 5856.3 5880.7 5881.7 5883.2 5889.1 5371.4 5574.6 5578.1 5578.5 5600.0 5597.7 5638.9 5669.4 5670.3 5670.7 5511.3 5538.9 5540.4 5558.9 5572.6 5459.9 5494.0 5511.9 5513.7 5531.7 5358.8 5368.7 5383.0 5465.1 5531.0 5503.1 5509.4 5539.9 5541.6 5596.6 5401.0 5478.6 5485.9 5493.4 5495.5 08:29:55 INFO - PROCESS | 3736 | 08:29:55 INFO - PROCESS | 3736 | [#1] ext.html Cycles:180 Average:51013.27 Median:35580.88 stddev:99351.09 (279.2%) stddev-sans-first:99557.56 08:29:55 INFO - PROCESS | 3736 | Values: 553.1 570.7 580.9 585.2 594.8 29174.9 30765.4 31844.5 31852.8 31864.2 38156.4 39225.8 39375.0 42726.6 42786.8 8373.6 8447.7 8486.8 8509.0 8509.0 7610.8 8501.7 8538.9 8573.8 8574.9 7563.0 9813.6 9986.0 10060.5 10319.1 10055.3 10079.3 10115.7 10124.8 10141.1 7542.6 10060.0 10119.9 10129.6 10130.3 28641.4 30506.4 30601.1 36076.5 39233.8 3124.4 3226.5 3274.3 3724.8 3851.5 29326.4 29727.0 29766.4 30122.0 31071.5 3508.6 3709.3 3724.1 3729.8 3816.0 291275.0 293499.0 294757.0 294905.0 295509.0 44090.3 51013.2 51493.2 51536.0 51545.0 45995.0 51871.7 53061.7 53347.2 57450.7 13997.2 14141.9 14167.4 14185.9 14186.6 11545.2 11732.2 11780.8 11785.5 11790.0 14740.5 15620.6 16524.2 16576.1 16653.0 6083.8 6323.8 6373.0 6485.2 6512.4 774.6 854.9 868.4 896.4 913.8 27638.0 28017.9 28099.7 28244.0 28334.4 911.8 929.6 942.8 962.5 974.6 14454.3 14616.5 14673.2 14865.9 15036.1 458656.0 462827.0 463050.0 463514.0 463538.0 48597.8 48706.0 49121.3 49159.3 49167.3 1121.2 1156.9 1163.1 1166.9 1170.0 26430.5 27119.2 27315.9 27488.0 27655.6 43302.4 43613.8 43667.6 43690.0 43704.8 295508.0 360377.0 361774.0 362486.0 363034.0 22142.1 22938.9 23830.4 24996.4 25398.5 40141.8 40260.0 40445.8 41407.0 41487.6 35371.3 35790.5 35928.6 36231.8 36235.5 35368.3 35820.5 35823.0 36102.5 36265.0 34390.5 34440.1 35002.6 35028.6 35086.0 31281.4 32381.8 32525.0 32583.0 32749.0 23093.8 23542.6 23813.4 23914.5 23939.5 08:29:55 INFO - PROCESS | 3736 | 08:29:55 INFO - PROCESS | 3736 | [#2] jquery.html Cycles:180 Average:24063.20 Median:5374.60 stddev:64473.67 (1199.6%) stddev-sans-first:64629.91 08:29:55 INFO - PROCESS | 3736 | Values: 332.5 345.9 352.3 353.4 374.3 16138.8 16842.0 18161.3 18283.6 18327.2 16205.0 16470.3 16805.9 16955.2 17089.2 5103.9 5359.7 5370.1 5373.6 5375.6 3957.0 4148.6 5229.9 5682.4 5877.0 5918.9 5963.9 5964.6 5972.8 5976.9 5756.4 5940.3 5990.7 5991.6 6000.3 4676.4 5238.3 5241.1 5245.9 5270.3 11634.4 13480.0 19550.6 20170.8 20191.4 1889.4 1995.3 1999.9 2049.4 2710.8 8634.1 8680.9 8689.9 8979.9 9097.0 1787.8 1793.5 1814.6 1839.2 1863.0 68128.7 75315.6 77435.0 78201.8 78422.2 8244.4 8808.3 8914.9 9884.2 10219.7 11458.8 11610.8 11625.4 11625.6 11636.2 6906.6 7171.5 7198.0 7221.3 7239.9 7136.0 7195.0 7289.8 7353.2 7466.8 3552.3 3598.4 3620.4 3641.2 3674.4 1603.3 1697.6 1710.9 1733.2 1784.6 773.4 774.4 788.0 861.5 917.9 16110.4 16790.2 16937.3 17002.0 17105.0 783.6 797.9 823.3 837.5 880.4 9087.9 9384.5 9470.1 9478.1 9553.8 387539.1 389635.0 389855.0 390858.0 390899.0 73045.0 73934.0 74159.4 74692.6 78632.0 825.5 862.6 876.8 878.0 878.2 12995.5 15429.2 15501.2 15663.6 15882.4 35910.0 35965.0 35983.5 36436.0 36616.5 48797.5 48922.8 48969.8 49710.3 50030.5 6359.7 6447.4 7592.1 7594.6 7801.1 9476.3 11466.4 11895.6 11978.7 12118.8 9524.2 9566.1 9701.8 9787.8 9892.7 9341.3 9599.7 9644.2 10044.6 10199.3 9773.6 9865.0 9950.5 9964.4 10546.1 6813.3 6903.9 6982.3 6996.7 7161.7 8599.9 9685.0 9728.2 9792.0 10198.0 08:29:55 INFO - PROCESS | 3736 | 08:29:55 INFO - PROCESS | 3736 | [#3] mootools.html Cycles:180 Average:5027.05 Median:4947.25 stddev:2963.85 (59.9%) stddev-sans-first:2958.40 08:29:55 INFO - PROCESS | 3736 | Values: 1225.5 1253.0 1293.4 1488.9 1493.0 7214.1 7702.5 7721.8 7722.7 7724.5 7002.6 7227.2 7507.9 7535.4 7717.5 1979.3 2009.1 2009.2 2014.8 2016.1 1939.0 1954.9 1957.3 1967.0 1973.3 1667.3 1772.2 1891.3 1949.2 1956.4 1961.6 1979.8 1981.6 1982.0 1982.3 1894.2 1904.3 1912.9 1919.0 1923.6 7752.2 7840.3 7870.1 7949.1 8104.3 4545.1 4648.3 4658.1 4662.4 4667.1 2856.2 2924.2 2973.4 2980.3 2985.4 914.9 922.8 926.6 941.0 941.3 10856.7 10922.6 10937.7 10939.0 10941.7 3861.7 3937.9 3961.9 3962.8 4165.0 8331.4 8452.6 8480.8 8486.3 8487.0 4546.9 4595.7 4618.6 4624.5 4625.2 4152.9 4354.9 4355.5 4358.1 4358.7 3269.3 3307.3 3329.1 3345.4 3368.8 994.3 998.1 1001.7 1008.5 1013.8 764.2 764.8 781.8 786.9 794.2 4888.6 4945.8 4948.7 4998.5 5133.0 344.4 349.6 352.6 353.2 363.9 3239.5 3287.4 3334.8 3342.0 3398.8 9561.2 9760.2 9774.0 9830.5 9879.7 9789.8 9836.3 9838.1 9838.3 9839.6 7010.2 7098.0 7100.3 7173.1 7397.6 4920.0 4953.9 4960.3 4989.1 5035.1 9011.9 9071.5 9113.8 9164.5 9173.8 8730.4 9097.2 9117.0 9295.8 9320.6 6852.9 6934.3 6996.7 7022.9 7025.5 7605.9 7623.9 7666.9 7682.9 7685.0 5965.3 6286.3 6795.5 6846.5 6923.7 6594.5 6644.8 6673.8 6704.2 6722.4 5909.9 5999.3 6003.5 6005.9 6007.2 4245.3 4290.2 4304.4 4350.8 4421.7 4332.4 4355.2 4380.3 4405.7 4405.8 08:29:55 INFO - PROCESS | 3736 | 08:29:55 INFO - PROCESS | 3736 | [#4] prototype.html Cycles:180 Average:4501.46 Median:5102.86 stddev:1350.16 (26.5%) stddev-sans-first:1316.50 08:29:55 INFO - PROCESS | 3736 | Values: 294.1 298.3 301.4 304.2 304.3 5262.4 5268.5 5310.7 5323.9 5339.8 5083.5 5122.0 5207.4 5219.4 5220.7 3727.7 3828.0 3830.3 3844.7 3850.3 3530.2 3874.5 3877.4 3879.8 3965.9 3907.9 3921.2 3942.0 3948.4 3958.1 3929.4 3974.3 3974.4 3979.0 3980.6 3233.6 3365.7 3414.3 3485.4 3525.9 4970.9 4989.4 4992.8 5043.2 5083.7 4584.9 4586.9 4588.8 4607.5 4665.1 5226.9 5279.1 5332.0 5460.9 5511.4 3690.3 3717.8 3725.3 3725.3 3728.2 5305.4 5445.9 5488.1 5565.6 5618.3 3947.9 3948.2 3957.8 3958.7 3961.2 4014.5 4065.2 4068.3 4070.5 4079.5 4486.7 4595.4 4627.9 4638.7 4668.2 5353.8 5365.2 5372.5 5376.2 5384.8 1350.9 1367.8 1378.6 1381.5 1391.6 837.4 875.0 879.2 894.3 895.2 4695.8 4708.7 4726.4 4741.0 4753.7 4864.0 4880.1 4913.4 4993.2 4998.6 4750.3 4777.2 4840.4 4876.9 5070.8 2956.0 2988.6 2988.8 2999.4 2999.4 5802.8 5811.9 5817.4 5820.0 5843.5 5439.6 5651.9 5680.0 5687.9 5711.5 5687.6 5771.5 5772.9 5787.5 5797.8 5362.7 5534.4 5614.8 5627.3 5648.4 5458.2 5480.4 5483.3 5486.4 5498.5 5538.1 5711.7 5713.9 5724.0 5795.9 3644.7 3688.7 3720.7 3727.2 3863.8 5574.2 5591.8 5619.8 5654.2 5658.3 5261.5 5358.8 5383.4 5393.8 5410.6 5374.3 5377.4 5392.1 5393.5 5400.5 5182.2 5303.7 5342.8 5360.2 5387.5 5487.8 5538.9 5550.6 5557.7 5562.2 5474.5 5481.5 5493.2 5515.2 5515.6 08:29:55 INFO - PROCESS | 3736 | 08:29:55 INFO - PROCESS | 3736 | [#5] yui.html Cycles:180 Average:18472.23 Median:482.79 stddev:26822.23 (5555.7%) stddev-sans-first:26863.79 08:29:55 INFO - PROCESS | 3736 | Values: 570.3 585.6 601.8 693.3 729.4 12622.4 13125.7 13178.9 13288.2 13313.5 13271.0 13304.9 13387.9 13459.0 13492.8 560.5 637.7 652.0 654.6 655.9 569.9 642.3 656.3 658.4 663.9 694.1 694.9 695.9 697.4 697.8 590.5 692.5 692.9 693.7 694.7 441.6 444.2 444.5 444.6 492.7 12981.8 13689.5 13713.3 13717.3 13719.0 11825.3 12005.3 12236.6 12313.8 13064.5 12122.4 12144.6 12154.7 12232.7 12550.1 4181.1 4208.1 4247.9 4280.4 4325.7 71497.6 71610.0 72276.0 73206.6 74569.0 9460.4 9461.2 9491.2 9492.5 9526.5 16279.1 16419.3 16578.4 16579.9 16635.1 7515.9 7574.6 7608.6 7751.2 7787.1 4021.4 4061.9 4072.9 4149.2 4204.3 2980.2 3127.1 3132.5 3140.7 3229.2 577.5 584.9 593.9 594.1 596.4 472.9 530.2 565.0 565.3 566.8 8931.6 9118.4 9122.4 9156.1 9178.1 647.5 660.6 669.2 681.7 686.6 4078.9 4085.6 4116.5 4120.6 4171.1 71586.6 92591.1 101755.5 106879.0 107263.0 90763.2 91189.0 92111.5 94685.5 95396.0 76282.9 77315.0 77443.0 77544.6 79609.0 7990.0 8072.8 8079.9 8165.0 8218.7 44640.6 44783.0 45290.5 45450.0 45976.8 60261.7 64957.0 66772.7 67198.7 68869.7 10249.0 10332.5 10683.4 10699.7 10956.5 12481.9 12557.4 12929.7 12991.7 13027.7 11585.2 11617.4 11986.3 12062.8 12336.2 11525.7 11552.9 11709.6 11830.3 12188.8 10921.6 11370.6 11472.4 11489.7 11680.2 9904.8 9958.4 10031.3 10305.9 10314.0 9892.3 9952.3 9974.5 9983.3 9989.6 08:29:55 INFO - PROCESS | 3736 | -------- Summary: end -------- 08:29:55 INFO - PROCESS | 3736 | 08:29:56 INFO - TEST-INFO | 3736: exit 0 08:29:57 INFO - TEST-OK | dromaeo_css | took 1124743ms 08:29:57 INFO - TEST-START | kraken 08:29:57 INFO - operating with platform_type : w8_ 08:29:57 INFO - Initialising browser for kraken test... 08:29:57 INFO - TEST-INFO | started process 696 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpx56tt_\profile http://localhost:49237/getInfo.html) 08:30:02 INFO - PROCESS | 696 | __metrics Screen width/height:1600/1200 08:30:02 INFO - PROCESS | 696 | colorDepth:24 08:30:02 INFO - PROCESS | 696 | Browser inner width/height: 1010/674 08:30:02 INFO - PROCESS | 696 | __metrics 08:30:03 INFO - PROCESS | 696 | 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" 08:30:03 INFO - PROCESS | 696 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:04 INFO - PROCESS | 696 | console.error: 08:30:04 INFO - PROCESS | 696 | Message: Error: Connection closed before committing the transaction. 08:30:04 INFO - PROCESS | 696 | Stack: 08:30:04 INFO - PROCESS | 696 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 08:30:04 INFO - PROCESS | 696 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 08:30:04 INFO - PROCESS | 696 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 08:30:04 INFO - PROCESS | 696 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 08:30:04 INFO - PROCESS | 696 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 08:30:04 INFO - PROCESS | 696 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 08:30:04 INFO - PROCESS | 696 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 08:30:04 INFO - PROCESS | 696 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 08:30:04 INFO - PROCESS | 696 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 08:30:04 INFO - PROCESS | 696 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 08:30:04 INFO - PROCESS | 696 | Barrier/this.client.addBlocker/promise13.3% 08:31:01 INFO - TinderboxPrint: I/O read bytes / time
273,898,496 / 3,085,030 08:31:01 INFO - TinderboxPrint: I/O write bytes / time
410,941,952 / 3,866,240 08:31:01 INFO - TinderboxPrint: CPU idle
8,269.9 (86.7%) 08:31:01 INFO - TinderboxPrint: CPU user
1,215.4 (12.7%) 08:31:01 INFO - install - Wall time: 3s; CPU: 11.0%; Read bytes: 0; Write bytes: 36271616; Read time: 0; Write time: 145390 08:31:01 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 273851904; Write bytes: 323494912; Read time: 3079140; Write time: 3679150 08:31:01 INFO - Running post-run listener: _upload_blobber_files 08:31:01 INFO - Blob upload gear active. 08:31:01 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 08:31:01 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 08:31:01 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'] 08:31:01 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 08:31:02 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:02 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 08:31:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:31:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:02 INFO - (blobuploader) - INFO - Done attempting. 08:31:02 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 08:31:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:03 INFO - (blobuploader) - INFO - Done attempting. 08:31:03 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 08:31:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:31:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:06 INFO - (blobuploader) - INFO - Done attempting. 08:31:06 INFO - (blobuploader) - INFO - Iteration through files over. 08:31:06 INFO - Return code: 0 08:31:06 INFO - rmtree: C:\slave\test\build\uploaded_files.json 08:31:06 INFO - Using _rmtree_windows ... 08:31:06 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 08:31:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca14142cf199be8e89e0c4a0b1dc5a55c4407150d19581589f83c483483ec5326d8056a7243ecd3d7ec40208b3f75ff808ead225e3f5f9c383d2c95fae63920c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef37266f1a63eb63045845b5ac37d6a68fd025e1adbeca0a44ed3de5f730129cbeaf43d266ca7281a6da7161454b411f4db9439915a34d40b69b0eae6b32a8fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83668fb6a00412c7a329169f0f6a159fc71bbd5cb5a716a4506b22510a9dec933f43d47c2a3163797373481963db0c617a386fc513a36bb98c45a04dfb427d22"} 08:31:06 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 08:31:06 INFO - Writing to file C:\slave\test\properties\blobber_files 08:31:06 INFO - Contents: 08:31:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca14142cf199be8e89e0c4a0b1dc5a55c4407150d19581589f83c483483ec5326d8056a7243ecd3d7ec40208b3f75ff808ead225e3f5f9c383d2c95fae63920c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef37266f1a63eb63045845b5ac37d6a68fd025e1adbeca0a44ed3de5f730129cbeaf43d266ca7281a6da7161454b411f4db9439915a34d40b69b0eae6b32a8fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83668fb6a00412c7a329169f0f6a159fc71bbd5cb5a716a4506b22510a9dec933f43d47c2a3163797373481963db0c617a386fc513a36bb98c45a04dfb427d22"} 08:31:06 INFO - Running post-run listener: copy_logs_to_upload_dir 08:31:06 INFO - Copying logs to upload dir... 08:31:06 INFO - mkdir: C:\slave\test\build\upload\logs 08:31:06 INFO - Copying logs to upload dir... 08:31:06 INFO - Using _rmtree_windows ... 08:31:06 INFO - Using _rmtree_windows ... 08:31:06 INFO - Using _rmtree_windows ... 08:31:06 INFO - Using _rmtree_windows ... 08:31:06 INFO - Using _rmtree_windows ... 08:31:06 INFO - Using _rmtree_windows ... 08:31:06 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1343.996000 ========= master_lag: -0.17 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 23 secs) (at 2016-10-18 08:31:06.607641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 08:31:06.608741) ========= '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-145\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-145 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-145 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-145\AppData\Local LOGONSERVER=\\T-W864-IX-145 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-145 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-145 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-145 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/ca14142cf199be8e89e0c4a0b1dc5a55c4407150d19581589f83c483483ec5326d8056a7243ecd3d7ec40208b3f75ff808ead225e3f5f9c383d2c95fae63920c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef37266f1a63eb63045845b5ac37d6a68fd025e1adbeca0a44ed3de5f730129cbeaf43d266ca7281a6da7161454b411f4db9439915a34d40b69b0eae6b32a8fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83668fb6a00412c7a329169f0f6a159fc71bbd5cb5a716a4506b22510a9dec933f43d47c2a3163797373481963db0c617a386fc513a36bb98c45a04dfb427d22"} build_url:https://queue.taskcluster.net/v1/task/I0zstixqSQ62mDVcVImycw/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/I0zstixqSQ62mDVcVImycw/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/ca14142cf199be8e89e0c4a0b1dc5a55c4407150d19581589f83c483483ec5326d8056a7243ecd3d7ec40208b3f75ff808ead225e3f5f9c383d2c95fae63920c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef37266f1a63eb63045845b5ac37d6a68fd025e1adbeca0a44ed3de5f730129cbeaf43d266ca7281a6da7161454b411f4db9439915a34d40b69b0eae6b32a8fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83668fb6a00412c7a329169f0f6a159fc71bbd5cb5a716a4506b22510a9dec933f43d47c2a3163797373481963db0c617a386fc513a36bb98c45a04dfb427d22"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 08:31:06.729221) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:31:06.729547) ========= '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-145\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-145 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-145 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-145\AppData\Local LOGONSERVER=\\T-W864-IX-145 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-145 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-145 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-145 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:31:07.052927) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-18 08:31:07.053236) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-18 08:31:07.574410) ========= ========= Total master_lag: 0.27 =========