builder: cedar_win8_64_test-dromaeojs slave: t-w864-ix-100 starttime: 1479497724.7 results: success (0) buildid: 20161118070428 builduid: c123361a476643a3b4591fdbee8e2568 revision: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 11:35:24.699300) ========= master: http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 11:35:24.699836) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 11:35:24.700145) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 11:35:24.849193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 11:35:24.849581) ========= '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-100\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-100 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-100 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-100\AppData\Local LOGONSERVER=\\T-W864-IX-100 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-100 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-100 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-100 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --11:35:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure HTTP request sent, awaiting response... 200 Script output follows Length: 12,179 (12K) [text/x-python] 0K .......... . 100% 8.57 MB/s 11:35:26 (8.57 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.240000 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 11:35:26.117106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-11-18 11:35:26.117421) ========= '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-100\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-100 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-100 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-100\AppData\Local LOGONSERVER=\\T-W864-IX-100 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-100 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-100 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-100 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=3.513000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-11-18 11:35:29.647356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 11:35:29.647720) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo projects/cedar --rev 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-100\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-100 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-100 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-100\AppData\Local LOGONSERVER=\\T-W864-IX-100 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-100 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-100 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-100 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-11-18 11:35:30,115 truncating revision to first 12 chars 2016-11-18 11:35:30,115 Setting DEBUG logging. 2016-11-18 11:35:30,115 attempt 1/10 2016-11-18 11:35:30,115 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/26b31d10e8cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 11:35:30,592 unpacking tar archive at: cedar-26b31d10e8cc/testing/mozharness/ 2016-11-18 11:35:30,706 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.602000 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 11:35:31.315493) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 11:35:31.316007) ========= script_repo_revision: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 11:35:31.316638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 11:35:31.317096) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 11:35:31.335245) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 28 secs) (at 2016-11-18 11:35:31.335571) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Cedar' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Cedar' 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', 'Cedar', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-100\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-100 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-100 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-100\AppData\Local LOGONSERVER=\\T-W864-IX-100 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-100 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-100 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-100 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 11:35:31 INFO - MultiFileLogger online at 20161118 11:35:31 in C:\slave\test 11:35:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 11:35:31 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 11:35:31 INFO - {'append_to_log': False, 11:35:31 INFO - 'base_work_dir': 'C:\\slave\\test', 11:35:31 INFO - 'blob_upload_branch': 'Cedar', 11:35:31 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 11:35:31 INFO - 'branch': 'Cedar', 11:35:31 INFO - 'buildbot_json_path': 'buildprops.json', 11:35:31 INFO - 'config_files': ('talos/windows_config.py',), 11:35:31 INFO - 'default_actions': ('clobber', 11:35:31 INFO - 'read-buildbot-config', 11:35:31 INFO - 'download-and-extract', 11:35:31 INFO - 'populate-webroot', 11:35:31 INFO - 'create-virtualenv', 11:35:31 INFO - 'install', 11:35:31 INFO - 'run-tests'), 11:35:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:35:31 INFO - 'download_minidump_stackwalk': True, 11:35:31 INFO - 'download_symbols': 'ondemand', 11:35:31 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 11:35:31 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 11:35:31 INFO - 'hg': 'c:/mozilla-build/hg/hg', 11:35:31 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 11:35:31 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 11:35:31 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 11:35:31 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 11:35:31 INFO - 'C:/mozilla-build/tooltool.py'), 11:35:31 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 11:35:31 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 11:35:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:35:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:35:31 INFO - 'installer_path': 'installer.exe', 11:35:31 INFO - 'log_level': 'info', 11:35:31 INFO - 'log_name': 'talos', 11:35:31 INFO - 'log_to_console': True, 11:35:31 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 11:35:31 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 11:35:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 11:35:31 INFO - 'opt_config_files': (), 11:35:31 INFO - 'pip_index': False, 11:35:31 INFO - 'sps_profile': False, 11:35:31 INFO - 'sps_profile_interval': 0, 11:35:31 INFO - 'suite': 'dromaeojs', 11:35:31 INFO - 'system_bits': '32', 11:35:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:35:31 INFO - 'title': 'T-W864-IX-100', 11:35:31 INFO - 'use_talos_json': True, 11:35:31 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 11:35:31 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 11:35:31 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 11:35:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:35:31 INFO - 'work_dir': 'build'} 11:35:31 INFO - [mozharness: 2016-11-18 19:35:31.940000Z] Running clobber step. 11:35:31 INFO - Running pre-action listener: _resource_record_pre_action 11:35:31 INFO - Running main action method: clobber 11:35:31 INFO - rmtree: C:\slave\test\build 11:35:31 INFO - Using _rmtree_windows ... 11:35:31 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 11:37:08 INFO - Running post-action listener: _resource_record_post_action 11:37:08 INFO - [mozharness: 2016-11-18 19:37:08.955000Z] Finished clobber step (success) 11:37:08 INFO - [mozharness: 2016-11-18 19:37:08.955000Z] Running read-buildbot-config step. 11:37:08 INFO - Running pre-action listener: _resource_record_pre_action 11:37:08 INFO - Running main action method: read_buildbot_config 11:37:08 INFO - Using buildbot properties: 11:37:08 INFO - { 11:37:08 INFO - "project": "", 11:37:08 INFO - "product": "firefox", 11:37:08 INFO - "script_repo_revision": "default", 11:37:08 INFO - "builddir": "cedar_win8_64_test-dromaeojs", 11:37:08 INFO - "repository": "", 11:37:08 INFO - "buildername": "Windows 8 64-bit cedar talos dromaeojs", 11:37:08 INFO - "buildid": "20161118070428", 11:37:08 INFO - "pgo_build": "False", 11:37:08 INFO - "basedir": "C:\\slave\\test", 11:37:08 INFO - "buildnumber": 3, 11:37:08 INFO - "slavename": "t-w864-ix-100", 11:37:08 INFO - "master": "http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/", 11:37:08 INFO - "platform": "win8_64", 11:37:08 INFO - "scheduler": "tests-cedar-win64-talos", 11:37:08 INFO - "branch": "cedar", 11:37:08 INFO - "repo_path": "projects/cedar", 11:37:08 INFO - "revision": "26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c", 11:37:08 INFO - "stage_platform": "win64", 11:37:08 INFO - "builduid": "c123361a476643a3b4591fdbee8e2568", 11:37:08 INFO - "slavebuilddir": "test" 11:37:08 INFO - } 11:37:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip. 11:37:08 INFO - Running post-action listener: _resource_record_post_action 11:37:08 INFO - [mozharness: 2016-11-18 19:37:08.958000Z] Finished read-buildbot-config step (success) 11:37:08 INFO - [mozharness: 2016-11-18 19:37:08.958000Z] Running download-and-extract step. 11:37:08 INFO - Running pre-action listener: _resource_record_pre_action 11:37:08 INFO - Running main action method: download_and_extract 11:37:08 INFO - mkdir: C:\slave\test\build\tests 11:37:08 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')]} 11:37:08 INFO - trying https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.test_packages.json 11:37:08 INFO - Downloading https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-53.0a1.en-US.win64.test_packages.json 11:37:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-53.0a1.en-US.win64.test_packages.json'}, attempt #1 11:37:09 INFO - Downloaded 1274 bytes. 11:37:09 INFO - Reading from file C:\slave\test\build\firefox-53.0a1.en-US.win64.test_packages.json 11:37:09 INFO - Using the following test package requirements: 11:37:09 INFO - {u'common': [u'firefox-53.0a1.en-US.win64.common.tests.zip'], 11:37:09 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 11:37:09 INFO - u'firefox-53.0a1.en-US.win64.cppunittest.tests.zip'], 11:37:09 INFO - u'gtest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 11:37:09 INFO - u'firefox-53.0a1.en-US.win64.gtest.tests.zip'], 11:37:09 INFO - u'jittest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 11:37:09 INFO - u'jsshell-win64.zip'], 11:37:09 INFO - u'mochitest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 11:37:09 INFO - u'firefox-53.0a1.en-US.win64.mochitest.tests.zip'], 11:37:09 INFO - u'mozbase': [u'firefox-53.0a1.en-US.win64.common.tests.zip'], 11:37:09 INFO - u'reftest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 11:37:09 INFO - u'firefox-53.0a1.en-US.win64.reftest.tests.zip'], 11:37:09 INFO - u'talos': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 11:37:09 INFO - u'firefox-53.0a1.en-US.win64.talos.tests.zip'], 11:37:09 INFO - u'web-platform': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 11:37:09 INFO - u'firefox-53.0a1.en-US.win64.web-platform.tests.zip'], 11:37:09 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 11:37:09 INFO - u'firefox-53.0a1.en-US.win64.xpcshell.tests.zip']} 11:37:09 INFO - Downloading packages: [u'firefox-53.0a1.en-US.win64.common.tests.zip'] for test suite category: common 11:37:09 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip 11:37:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip'}, attempt #1 11:37:09 INFO - Fetch https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip into memory 11:37:10 INFO - Http code: 200 11:37:10 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 11:37:10 INFO - x-amz-cf-id: q2RlNfFXlRV-V-wN0l-iJ9beyInM7HxJC2ARj9c2nvfX1KgT6gTYLg== 11:37:10 INFO - x-amz-version-id: wD.hHnRmmuqvFx6MvzcKo02xaALzs8m1 11:37:10 INFO - Expected file size: 17269948 11:37:10 INFO - Obtained file size: 17269948 11:37:39 INFO - Downloading packages: [u'firefox-53.0a1.en-US.win64.common.tests.zip', u'firefox-53.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 11:37:39 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip 11:37:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip'}, attempt #1 11:37:39 INFO - Fetch https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip into memory 11:37:39 INFO - Http code: 200 11:37:39 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 11:37:39 INFO - x-amz-cf-id: n2a5nmA4Esn4Jz8BQAE4H63WDJk2As_yH4wXYF62UFy2GleFcXhc0A== 11:37:39 INFO - x-amz-version-id: wD.hHnRmmuqvFx6MvzcKo02xaALzs8m1 11:37:40 INFO - Expected file size: 17269948 11:37:40 INFO - Obtained file size: 17269948 11:37:50 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip 11:37:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip'}, attempt #1 11:37:50 INFO - Fetch https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip into memory 11:37:50 INFO - Http code: 200 11:37:50 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 11:37:50 INFO - x-amz-cf-id: m7B2TRxu2ZzsRX6k2dpjOSTqWYHIh7xsSDlCxJB6jCEQQpSnhmbjxw== 11:37:50 INFO - x-amz-version-id: qlBsKYGJ9SroKJrRTLxGynO1OTVe9eSb 11:37:51 INFO - Expected file size: 14409392 11:37:51 INFO - Obtained file size: 14409392 11:38:01 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')]} 11:38:01 INFO - trying https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 11:38:01 INFO - Downloading https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip to C:\slave\test\build\firefox-53.0a1.en-US.win64.zip 11:38:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-53.0a1.en-US.win64.zip'}, attempt #1 11:38:02 INFO - Downloaded 57166359 bytes. 11:38:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 11:38:02 INFO - mkdir: C:\slave\test\properties 11:38:02 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 11:38:02 INFO - Writing to file C:\slave\test\properties\build_url 11:38:02 INFO - Contents: 11:38:02 INFO - build_url:https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 11:38:03 INFO - Running post-action listener: _resource_record_post_action 11:38:03 INFO - Running post-action listener: set_extra_try_arguments 11:38:03 INFO - [mozharness: 2016-11-18 19:38:03.607000Z] Finished download-and-extract step (success) 11:38:03 INFO - [mozharness: 2016-11-18 19:38:03.607000Z] Running populate-webroot step. 11:38:03 INFO - Running pre-action listener: _resource_record_pre_action 11:38:03 INFO - Running main action method: populate_webroot 11:38:03 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 11:38:03 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 11:38:03 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 11:38:03 INFO - u'--tppagecycles', 11:38:03 INFO - u'7'], 11:38:03 INFO - u'tests': [u'tsvgm']}}, 11:38:03 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 11:38:03 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 11:38:03 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 11:38:03 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 11:38:03 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 11:38:03 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 11:38:03 INFO - u'g1': {u'pagesets_name': u'tp5n.zip', 11:38:03 INFO - u'talos_options': [u'--disable-e10s'], 11:38:03 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 11:38:03 INFO - u'g1-e10s': {u'pagesets_name': u'tp5n.zip', 11:38:03 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 11:38:03 INFO - u'g2': {u'pagesets_name': u'tp5n.zip', 11:38:03 INFO - u'talos_options': [u'--disable-e10s'], 11:38:03 INFO - u'tests': [u'damp', u'tps']}, 11:38:03 INFO - u'g2-e10s': {u'pagesets_name': u'tp5n.zip', 11:38:03 INFO - u'tests': [u'damp', u'tps']}, 11:38:03 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 11:38:03 INFO - u'tests': [u'dromaeo_dom']}, 11:38:03 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 11:38:03 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 11:38:03 INFO - u'tests': [u'basic_compositor_video']}, 11:38:03 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 11:38:03 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 11:38:03 INFO - u'tests': [u'a11yr', 11:38:03 INFO - u'ts_paint', 11:38:03 INFO - u'tpaint', 11:38:03 INFO - u'sessionrestore', 11:38:03 INFO - u'sessionrestore_no_auto_restore', 11:38:03 INFO - u'tabpaint']}, 11:38:03 INFO - u'other-e10s': {u'tests': [u'a11yr', 11:38:03 INFO - u'ts_paint', 11:38:03 INFO - u'tpaint', 11:38:03 INFO - u'sessionrestore', 11:38:03 INFO - u'sessionrestore_no_auto_restore', 11:38:03 INFO - u'tabpaint']}, 11:38:03 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 11:38:03 INFO - u'ts_paint', 11:38:03 INFO - u'tpaint', 11:38:03 INFO - u'sessionrestore', 11:38:03 INFO - u'sessionrestore_no_auto_restore', 11:38:03 INFO - u'tabpaint']}, 11:38:03 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 11:38:03 INFO - u'ts_paint', 11:38:03 INFO - u'tpaint', 11:38:03 INFO - u'sessionrestore', 11:38:03 INFO - u'sessionrestore_no_auto_restore', 11:38:03 INFO - u'tabpaint']}, 11:38:03 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 11:38:03 INFO - u'tests': [u'a11yr', 11:38:03 INFO - u'ts_paint', 11:38:03 INFO - u'tpaint', 11:38:03 INFO - u'sessionrestore', 11:38:03 INFO - u'sessionrestore_no_auto_restore', 11:38:03 INFO - u'tabpaint']}, 11:38:03 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 11:38:03 INFO - u'tests': [u'a11yr', 11:38:03 INFO - u'ts_paint', 11:38:03 INFO - u'tpaint', 11:38:03 INFO - u'sessionrestore', 11:38:03 INFO - u'sessionrestore_no_auto_restore', 11:38:03 INFO - u'tabpaint']}, 11:38:03 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 11:38:03 INFO - u'tests': [u'tsvgx', 11:38:03 INFO - u'tsvgr_opacity', 11:38:03 INFO - u'tart', 11:38:03 INFO - u'tscrollx', 11:38:03 INFO - u'cart']}, 11:38:03 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 11:38:03 INFO - u'tsvgr_opacity', 11:38:03 INFO - u'tart', 11:38:03 INFO - u'tscrollx', 11:38:03 INFO - u'cart']}, 11:38:03 INFO - u'tp5o': {u'pagesets_name': u'tp5n.zip', 11:38:03 INFO - u'talos_options': [u'--disable-e10s'], 11:38:03 INFO - u'tests': [u'tp5o']}, 11:38:03 INFO - u'tp5o-e10s': {u'pagesets_name': u'tp5n.zip', 11:38:03 INFO - u'tests': [u'tp5o']}, 11:38:03 INFO - u'xperf': {u'pagesets_name': u'tp5n.zip', 11:38:03 INFO - u'talos_options': [u'--disable-e10s', 11:38:03 INFO - u'--xperf_path', 11:38:03 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:03 INFO - u'tests': [u'tp5n']}, 11:38:03 INFO - u'xperf-e10s': {u'pagesets_name': u'tp5n.zip', 11:38:03 INFO - u'talos_options': [u'--xperf_path', 11:38:03 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:03 INFO - u'tests': [u'tp5n']}}, 11:38:03 INFO - u'talos.zip': {u'path': u'', 11:38:03 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:38:03 INFO - Running post-action listener: _resource_record_post_action 11:38:03 INFO - [mozharness: 2016-11-18 19:38:03.622000Z] Finished populate-webroot step (success) 11:38:03 INFO - [mozharness: 2016-11-18 19:38:03.622000Z] Running create-virtualenv step. 11:38:03 INFO - Running pre-action listener: _resource_record_pre_action 11:38:03 INFO - Running main action method: create_virtualenv 11:38:03 INFO - Creating virtualenv C:\slave\test\build/venv 11:38:03 INFO - mkdir: C:\slave\test\build\venv\Scripts 11:38:04 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 11:38:04 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 11:38:04 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build 11:38:04 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 11:38:16 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 11:38:19 INFO - Installing distribute......................................................................................................................................................................................done. 11:38:20 INFO - Return code: 0 11:38:20 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 11:38:20 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 11:38:21 INFO - Reading from file tmpfile_stdout 11:38:21 INFO - Output received: 11:38:21 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 11:38:21 INFO - Using _rmtree_windows ... 11:38:21 INFO - Using _rmtree_windows ... 11:38:21 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 11:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:21 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0284E020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007AE0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02350E90>, '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 0x0071A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023325C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-100', 'USERDOMAIN': 'T-W864-IX-100', '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-100', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-100', '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-100\\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 11:38:21 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build 11:38:21 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:38:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:38:21 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Roaming', 11:38:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:38:21 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:38:21 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:38:21 INFO - 'COMPUTERNAME': 'T-W864-IX-100', 11:38:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:38:21 INFO - 'DCLOCATION': 'SCL3', 11:38:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:38:21 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:38:21 INFO - 'HOMEDRIVE': 'C:', 11:38:21 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 11:38:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:38:21 INFO - 'KTS_VERSION': '1.19c', 11:38:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 11:38:21 INFO - 'LOGONSERVER': '\\\\T-W864-IX-100', 11:38:21 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:38:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:21 INFO - 'MOZ_NO_REMOTE': '1', 11:38:21 INFO - 'NO_EM_RESTART': '1', 11:38:21 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:38:21 INFO - 'OS': 'Windows_NT', 11:38:21 INFO - 'OURDRIVE': 'C:', 11:38:21 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:38:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:38:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:38:21 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:38:21 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:38:21 INFO - 'PROCESSOR_LEVEL': '6', 11:38:21 INFO - 'PROCESSOR_REVISION': '1e05', 11:38:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:38:21 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:38:21 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:38:21 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:38:21 INFO - 'PROMPT': '$P$G', 11:38:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:38:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:38:21 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:38:21 INFO - 'PWD': 'C:\\slave\\test', 11:38:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:38:21 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:38:21 INFO - 'SYSTEMDRIVE': 'C:', 11:38:21 INFO - 'SYSTEMROOT': 'C:\\windows', 11:38:21 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:21 INFO - 'TEST1': 'testie', 11:38:21 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:21 INFO - 'USERDOMAIN': 'T-W864-IX-100', 11:38:21 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 11:38:21 INFO - 'USERNAME': 'cltbld', 11:38:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-100', 11:38:21 INFO - 'WINDIR': 'C:\\windows', 11:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:38:22 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:38:22 INFO - Downloading/unpacking pip>=1.5 11:38:26 INFO - Running setup.py egg_info for package pip 11:38:26 INFO - warning: no files found matching 'pip\cacert.pem' 11:38:26 INFO - warning: no files found matching '*.html' under directory 'docs' 11:38:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 11:38:26 INFO - no previously-included directories found matching 'docs\_build\_sources' 11:38:26 INFO - Installing collected packages: pip 11:38:26 INFO - Found existing installation: pip 0.8.2 11:38:26 INFO - Uninstalling pip: 11:38:26 INFO - Successfully uninstalled pip 11:38:26 INFO - Running setup.py install for pip 11:38:26 INFO - warning: no files found matching 'pip\cacert.pem' 11:38:26 INFO - warning: no files found matching '*.html' under directory 'docs' 11:38:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 11:38:26 INFO - no previously-included directories found matching 'docs\_build\_sources' 11:38:26 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 11:38:26 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 11:38:26 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 11:38:26 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 11:38:26 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 11:38:26 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 11:38:26 INFO - Successfully installed pip 11:38:26 INFO - Cleaning up... 11:38:26 INFO - Return code: 0 11:38:26 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 11:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:26 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0284E020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007AE0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02350E90>, '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 0x0071A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023325C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-100', 'USERDOMAIN': 'T-W864-IX-100', '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-100', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-100', '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-100\\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 11:38:26 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build 11:38:26 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:38:26 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:38:26 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Roaming', 11:38:26 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:38:26 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:38:26 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:38:26 INFO - 'COMPUTERNAME': 'T-W864-IX-100', 11:38:26 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:38:26 INFO - 'DCLOCATION': 'SCL3', 11:38:26 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:38:26 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:38:26 INFO - 'HOMEDRIVE': 'C:', 11:38:26 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 11:38:26 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:38:26 INFO - 'KTS_VERSION': '1.19c', 11:38:26 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 11:38:26 INFO - 'LOGONSERVER': '\\\\T-W864-IX-100', 11:38:26 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:38:26 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:26 INFO - 'MOZ_NO_REMOTE': '1', 11:38:26 INFO - 'NO_EM_RESTART': '1', 11:38:26 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:38:26 INFO - 'OS': 'Windows_NT', 11:38:26 INFO - 'OURDRIVE': 'C:', 11:38:26 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:38:26 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:38:26 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:38:26 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:38:26 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:38:26 INFO - 'PROCESSOR_LEVEL': '6', 11:38:26 INFO - 'PROCESSOR_REVISION': '1e05', 11:38:26 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:38:26 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:38:26 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:38:26 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:38:26 INFO - 'PROMPT': '$P$G', 11:38:26 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:38:26 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:38:26 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:38:26 INFO - 'PWD': 'C:\\slave\\test', 11:38:26 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:38:26 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:38:26 INFO - 'SYSTEMDRIVE': 'C:', 11:38:26 INFO - 'SYSTEMROOT': 'C:\\windows', 11:38:26 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:26 INFO - 'TEST1': 'testie', 11:38:26 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:26 INFO - 'USERDOMAIN': 'T-W864-IX-100', 11:38:26 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 11:38:26 INFO - 'USERNAME': 'cltbld', 11:38:26 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-100', 11:38:26 INFO - 'WINDIR': 'C:\\windows', 11:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:28 INFO - Downloading/unpacking psutil>=3.1.1 11:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:29 INFO - Installing collected packages: psutil 11:38:29 INFO - Successfully installed psutil 11:38:29 INFO - Cleaning up... 11:38:30 INFO - Return code: 0 11:38:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 11:38: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')]} 11:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38: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')]} 11:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0284E020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007AE0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02350E90>, '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 0x0071A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023325C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-100', 'USERDOMAIN': 'T-W864-IX-100', '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-100', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-100', '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-100\\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 11:38: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', 'mozsystemmonitor==0.3'] in C:\slave\test\build 11:38: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 mozsystemmonitor==0.3 11:38:30 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:38:30 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Roaming', 11:38:30 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:38:30 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:38:30 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:38:30 INFO - 'COMPUTERNAME': 'T-W864-IX-100', 11:38:30 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:38:30 INFO - 'DCLOCATION': 'SCL3', 11:38:30 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:38:30 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:38:30 INFO - 'HOMEDRIVE': 'C:', 11:38:30 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 11:38:30 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:38:30 INFO - 'KTS_VERSION': '1.19c', 11:38:30 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 11:38:30 INFO - 'LOGONSERVER': '\\\\T-W864-IX-100', 11:38:30 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:38:30 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:30 INFO - 'MOZ_NO_REMOTE': '1', 11:38:30 INFO - 'NO_EM_RESTART': '1', 11:38:30 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:38:30 INFO - 'OS': 'Windows_NT', 11:38:30 INFO - 'OURDRIVE': 'C:', 11:38: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', 11:38:30 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:38:30 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:38:30 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:38:30 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:38:30 INFO - 'PROCESSOR_LEVEL': '6', 11:38:30 INFO - 'PROCESSOR_REVISION': '1e05', 11:38:30 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:38:30 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:38:30 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:38:30 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:38:30 INFO - 'PROMPT': '$P$G', 11:38:30 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:38:30 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:38:30 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:38:30 INFO - 'PWD': 'C:\\slave\\test', 11:38:30 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:38:30 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:38:30 INFO - 'SYSTEMDRIVE': 'C:', 11:38:30 INFO - 'SYSTEMROOT': 'C:\\windows', 11:38:30 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:30 INFO - 'TEST1': 'testie', 11:38:30 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:30 INFO - 'USERDOMAIN': 'T-W864-IX-100', 11:38:30 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 11:38:30 INFO - 'USERNAME': 'cltbld', 11:38:30 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-100', 11:38:30 INFO - 'WINDIR': 'C:\\windows', 11:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:38:30 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 11:38:30 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 11:38:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:38:31 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 11:38:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.3) 11:38:31 INFO - Installing collected packages: mozsystemmonitor 11:38:31 INFO - Running setup.py install for mozsystemmonitor 11:38:31 INFO - Successfully installed mozsystemmonitor 11:38:31 INFO - Cleaning up... 11:38:32 INFO - Return code: 0 11:38:32 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 11:38:32 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')]} 11:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:32 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')]} 11:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:32 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 0x022A8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0284E020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007AE0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02350E90>, '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 0x0071A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023325C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-100', 'USERDOMAIN': 'T-W864-IX-100', '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-100', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-100', '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-100\\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 11:38:32 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 11:38:32 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 11:38:32 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:38:32 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Roaming', 11:38:32 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:38:32 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:38:32 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:38:32 INFO - 'COMPUTERNAME': 'T-W864-IX-100', 11:38:32 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:38:32 INFO - 'DCLOCATION': 'SCL3', 11:38:32 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:38:32 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:38:32 INFO - 'HOMEDRIVE': 'C:', 11:38:32 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 11:38:32 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:38:32 INFO - 'KTS_VERSION': '1.19c', 11:38:32 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 11:38:32 INFO - 'LOGONSERVER': '\\\\T-W864-IX-100', 11:38:32 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:38:32 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:32 INFO - 'MOZ_NO_REMOTE': '1', 11:38:32 INFO - 'NO_EM_RESTART': '1', 11:38:32 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:38:32 INFO - 'OS': 'Windows_NT', 11:38:32 INFO - 'OURDRIVE': 'C:', 11:38:32 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', 11:38:32 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:38:32 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:38:32 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:38:32 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:38:32 INFO - 'PROCESSOR_LEVEL': '6', 11:38:32 INFO - 'PROCESSOR_REVISION': '1e05', 11:38:32 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:38:32 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:38:32 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:38:32 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:38:32 INFO - 'PROMPT': '$P$G', 11:38:32 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:38:32 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:38:32 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:38:32 INFO - 'PWD': 'C:\\slave\\test', 11:38:32 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:38:32 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:38:32 INFO - 'SYSTEMDRIVE': 'C:', 11:38:32 INFO - 'SYSTEMROOT': 'C:\\windows', 11:38:32 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:32 INFO - 'TEST1': 'testie', 11:38:32 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:32 INFO - 'USERDOMAIN': 'T-W864-IX-100', 11:38:32 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 11:38:32 INFO - 'USERNAME': 'cltbld', 11:38:32 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-100', 11:38:32 INFO - 'WINDIR': 'C:\\windows', 11:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:32 INFO - Downloading/unpacking jsonschema==2.5.1 11:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:38:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:38:33 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 11:38:33 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 11:38:33 INFO - Downloading functools32-3.2.3-2.tar.gz 11:38:33 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 11:38:33 INFO - warning: no files found matching '*.txt' 11:38:33 INFO - no previously-included directories found matching 'build' 11:38:33 INFO - no previously-included directories found matching 'dist' 11:38:33 INFO - no previously-included directories found matching '.git*' 11:38:33 INFO - Installing collected packages: jsonschema, functools32 11:38:33 INFO - Running setup.py install for functools32 11:38:34 INFO - warning: no files found matching '*.txt' 11:38:34 INFO - no previously-included directories found matching 'build' 11:38:34 INFO - no previously-included directories found matching 'dist' 11:38:34 INFO - no previously-included directories found matching '.git*' 11:38:34 INFO - Successfully installed jsonschema functools32 11:38:34 INFO - Cleaning up... 11:38:34 INFO - Return code: 0 11:38:34 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 11:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:34 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x022A8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0284E020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007AE0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02350E90>, '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 0x0071A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023325C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-100', 'USERDOMAIN': 'T-W864-IX-100', '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-100', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-100', '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-100\\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 11:38:34 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 11:38:34 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:38:34 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:38:34 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Roaming', 11:38:34 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:38:34 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:38:34 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:38:34 INFO - 'COMPUTERNAME': 'T-W864-IX-100', 11:38:34 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:38:34 INFO - 'DCLOCATION': 'SCL3', 11:38:34 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:38:34 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:38:34 INFO - 'HOMEDRIVE': 'C:', 11:38:34 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 11:38:34 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:38:34 INFO - 'KTS_VERSION': '1.19c', 11:38:34 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 11:38:34 INFO - 'LOGONSERVER': '\\\\T-W864-IX-100', 11:38:34 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:38:34 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:34 INFO - 'MOZ_NO_REMOTE': '1', 11:38:34 INFO - 'NO_EM_RESTART': '1', 11:38:34 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:38:34 INFO - 'OS': 'Windows_NT', 11:38:34 INFO - 'OURDRIVE': 'C:', 11:38:34 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:38:34 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:38:34 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:38:34 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:38:34 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:38:34 INFO - 'PROCESSOR_LEVEL': '6', 11:38:34 INFO - 'PROCESSOR_REVISION': '1e05', 11:38:34 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:38:34 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:38:34 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:38:34 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:38:34 INFO - 'PROMPT': '$P$G', 11:38:34 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:38:34 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:38:34 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:38:34 INFO - 'PWD': 'C:\\slave\\test', 11:38:34 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:38:34 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:38:34 INFO - 'SYSTEMDRIVE': 'C:', 11:38:34 INFO - 'SYSTEMROOT': 'C:\\windows', 11:38:34 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:34 INFO - 'TEST1': 'testie', 11:38:34 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:34 INFO - 'USERDOMAIN': 'T-W864-IX-100', 11:38:34 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 11:38:34 INFO - 'USERNAME': 'cltbld', 11:38:34 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-100', 11:38:34 INFO - 'WINDIR': 'C:\\windows', 11:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 11:38:34 INFO - Cleaning up... 11:38:34 INFO - Return code: 0 11:38:34 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 11:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:34 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0284E020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007AE0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02350E90>, '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 0x0071A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023325C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-100', 'USERDOMAIN': 'T-W864-IX-100', '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-100', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-100', '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-100\\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 11:38:34 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build 11:38:34 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:38:34 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:38:34 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Roaming', 11:38:34 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:38:34 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:38:34 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:38:34 INFO - 'COMPUTERNAME': 'T-W864-IX-100', 11:38:34 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:38:34 INFO - 'DCLOCATION': 'SCL3', 11:38:34 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:38:34 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:38:34 INFO - 'HOMEDRIVE': 'C:', 11:38:34 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 11:38:34 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:38:34 INFO - 'KTS_VERSION': '1.19c', 11:38:34 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 11:38:34 INFO - 'LOGONSERVER': '\\\\T-W864-IX-100', 11:38:34 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:38:34 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:34 INFO - 'MOZ_NO_REMOTE': '1', 11:38:34 INFO - 'NO_EM_RESTART': '1', 11:38:34 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:38:34 INFO - 'OS': 'Windows_NT', 11:38:34 INFO - 'OURDRIVE': 'C:', 11:38:34 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:38:34 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:38:34 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:38:34 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:38:34 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:38:34 INFO - 'PROCESSOR_LEVEL': '6', 11:38:34 INFO - 'PROCESSOR_REVISION': '1e05', 11:38:34 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:38:34 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:38:34 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:38:34 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:38:34 INFO - 'PROMPT': '$P$G', 11:38:34 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:38:34 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:38:34 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:38:34 INFO - 'PWD': 'C:\\slave\\test', 11:38:34 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:38:34 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:38:34 INFO - 'SYSTEMDRIVE': 'C:', 11:38:34 INFO - 'SYSTEMROOT': 'C:\\windows', 11:38:34 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:34 INFO - 'TEST1': 'testie', 11:38:34 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:34 INFO - 'USERDOMAIN': 'T-W864-IX-100', 11:38:34 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 11:38:34 INFO - 'USERNAME': 'cltbld', 11:38:34 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-100', 11:38:34 INFO - 'WINDIR': 'C:\\windows', 11:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:35 INFO - Downloading/unpacking blobuploader==1.2.4 11:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:38:36 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 11:38:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:38:36 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 11:38:36 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 11:38:36 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 11:38:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:38:36 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 11:38:36 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 11:38:36 INFO - Downloading docopt-0.6.1.tar.gz 11:38:36 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 11:38:37 INFO - Installing collected packages: blobuploader, requests, docopt 11:38:37 INFO - Running setup.py install for blobuploader 11:38:37 INFO - Running setup.py install for requests 11:38:37 INFO - Running setup.py install for docopt 11:38:37 INFO - Successfully installed blobuploader requests docopt 11:38:37 INFO - Cleaning up... 11:38:38 INFO - Return code: 0 11:38:38 INFO - Installing None into virtualenv C:\slave\test\build/venv 11:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:39 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 0x022A8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0284E020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007AE0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02350E90>, '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 0x0071A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023325C0>, '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-100', 'USERDOMAIN': 'T-W864-IX-100', '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-100', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-100', '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-100\\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 11:38:39 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 11:38:39 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 11:38:39 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:38:39 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Roaming', 11:38:39 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:38:39 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:38:39 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:38:39 INFO - 'COMPUTERNAME': 'T-W864-IX-100', 11:38:39 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:38:39 INFO - 'DCLOCATION': 'SCL3', 11:38:39 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:38:39 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:38:39 INFO - 'HOMEDRIVE': 'C:', 11:38:39 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 11:38:39 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:38:39 INFO - 'KTS_VERSION': '1.19c', 11:38:39 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 11:38:39 INFO - 'LOGONSERVER': '\\\\T-W864-IX-100', 11:38:39 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:38:39 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:39 INFO - 'MOZ_NO_REMOTE': '1', 11:38:39 INFO - 'NO_EM_RESTART': '1', 11:38:39 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:38:39 INFO - 'OS': 'Windows_NT', 11:38:39 INFO - 'OURDRIVE': 'C:', 11:38:39 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:38:39 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:38:39 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:38:39 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:38:39 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:38:39 INFO - 'PROCESSOR_LEVEL': '6', 11:38:39 INFO - 'PROCESSOR_REVISION': '1e05', 11:38:39 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:38:39 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:38:39 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:38:39 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:38:39 INFO - 'PROMPT': '$P$G', 11:38:39 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:38:39 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:38:39 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:38:39 INFO - 'PWD': 'C:\\slave\\test', 11:38:39 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:38:39 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:38:39 INFO - 'SYSTEMDRIVE': 'C:', 11:38:39 INFO - 'SYSTEMROOT': 'C:\\windows', 11:38:39 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:39 INFO - 'TEST1': 'testie', 11:38:39 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:39 INFO - 'USERDOMAIN': 'T-W864-IX-100', 11:38:39 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 11:38:39 INFO - 'USERNAME': 'cltbld', 11:38:39 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-100', 11:38:39 INFO - 'WINDIR': 'C:\\windows', 11:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:38:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 11:38:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0mnul8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 11:38:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 11:38:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lhigwn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 11:38:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 11:38:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t1i_cx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 11:38:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 11:38:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-02lgie-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 11:38:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 11:38:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-burp1a-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 11:38:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 11:38:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-icmi0d-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 11:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 11:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-idtchr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 11:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 11:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dt37fy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 11:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 11:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-edryiz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 11:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 11:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ychqyb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 11:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 11:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kbvml2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 11:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 11:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ngcb0e-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 11:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 11:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-39kox0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 11:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 11:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4xpi1p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 11:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 11:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mckdg9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 11:38:41 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 11:38:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ipvtu4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 11:38:41 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 11:38:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ujd2bw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 11:38:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:38:41 INFO - Running setup.py install for manifestparser 11:38:41 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 11:38:41 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 11:38:42 INFO - Running setup.py install for mozcrash 11:38:42 INFO - Running setup.py install for mozdebug 11:38:43 INFO - Running setup.py install for mozdevice 11:38:43 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 11:38:43 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 11:38:43 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 11:38:43 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 11:38:43 INFO - Running setup.py install for mozfile 11:38:44 INFO - Running setup.py install for mozhttpd 11:38:44 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 11:38:44 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 11:38:44 INFO - Running setup.py install for mozinfo 11:38:44 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 11:38:44 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 11:38:45 INFO - Running setup.py install for mozInstall 11:38:45 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 11:38:45 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 11:38:45 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 11:38:45 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 11:38:45 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 11:38:45 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 11:38:45 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 11:38:45 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 11:38:45 INFO - Running setup.py install for mozleak 11:38:45 INFO - Running setup.py install for mozlog 11:38:45 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 11:38:45 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 11:38:46 INFO - Running setup.py install for moznetwork 11:38:46 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 11:38:46 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 11:38:47 INFO - Running setup.py install for mozprocess 11:38:47 INFO - Running setup.py install for mozprofile 11:38:47 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 11:38:47 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 11:38:47 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 11:38:47 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 11:38:47 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 11:38:47 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 11:38:48 INFO - Running setup.py install for mozrunner 11:38:48 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 11:38:48 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 11:38:49 INFO - Running setup.py install for mozscreenshot 11:38:49 INFO - Running setup.py install for moztest 11:38:50 INFO - Running setup.py install for mozversion 11:38:50 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 11:38:50 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 11:38:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:38:50 INFO - Cleaning up... 11:38:50 INFO - Return code: 0 11:38:50 INFO - Installing None into virtualenv C:\slave\test\build/venv 11:38:50 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')]} 11:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:50 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')]} 11:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:50 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 0x022A8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0284E020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007AE0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02350E90>, '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 0x0071A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023325C0>, '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-100', 'USERDOMAIN': 'T-W864-IX-100', '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-100', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-100', '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-100\\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 11:38:50 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 11:38:50 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 11:38:50 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:38:50 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Roaming', 11:38:50 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:38:50 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:38:50 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:38:50 INFO - 'COMPUTERNAME': 'T-W864-IX-100', 11:38:50 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:38:50 INFO - 'DCLOCATION': 'SCL3', 11:38:50 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:38:50 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:38:50 INFO - 'HOMEDRIVE': 'C:', 11:38:50 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 11:38:50 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:38:50 INFO - 'KTS_VERSION': '1.19c', 11:38:50 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 11:38:50 INFO - 'LOGONSERVER': '\\\\T-W864-IX-100', 11:38:50 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:38:50 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:50 INFO - 'MOZ_NO_REMOTE': '1', 11:38:50 INFO - 'NO_EM_RESTART': '1', 11:38:50 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:38:50 INFO - 'OS': 'Windows_NT', 11:38:50 INFO - 'OURDRIVE': 'C:', 11:38:50 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', 11:38:50 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:38:50 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:38:50 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:38:50 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:38:50 INFO - 'PROCESSOR_LEVEL': '6', 11:38:50 INFO - 'PROCESSOR_REVISION': '1e05', 11:38:50 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:38:50 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:38:50 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:38:50 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:38:50 INFO - 'PROMPT': '$P$G', 11:38:50 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:38:50 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:38:50 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:38:50 INFO - 'PWD': 'C:\\slave\\test', 11:38:50 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:38:50 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:38:50 INFO - 'SYSTEMDRIVE': 'C:', 11:38:50 INFO - 'SYSTEMROOT': 'C:\\windows', 11:38:50 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:50 INFO - 'TEST1': 'testie', 11:38:50 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:50 INFO - 'USERDOMAIN': 'T-W864-IX-100', 11:38:50 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 11:38:50 INFO - 'USERNAME': 'cltbld', 11:38:50 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-100', 11:38:50 INFO - 'WINDIR': 'C:\\windows', 11:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 11:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o74r3m-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 11:38:51 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)) 11:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 11:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2_v89j-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 11:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 11:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 11:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ypi05n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 11:38:51 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)) 11:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 11:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dxmtsu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 11:38:51 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)) 11:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 11:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tjblch-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 11:38:51 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)) 11:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 11:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wu0zmn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 11:38:51 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)) 11:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 11:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-f8fyyi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 11:38:51 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)) 11:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 11:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-n1tpcg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 11:38:51 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)) 11:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 11:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2rx64q-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 11:38:52 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)) 11:38:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 11:38:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uqs26i-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 11:38:52 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)) 11:38:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 11:38:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rwbirp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 11:38:52 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)) 11:38:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 11:38:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_w3vn7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 11:38:52 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)) 11:38:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 11:38:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yptnpv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 11:38:52 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)) 11:38:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 11:38:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ud22yx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 11:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 11:38:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 11:38:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dgf_hc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 11:38:52 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)) 11:38:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 11:38:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pu5071-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 11:38:52 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)) 11:38:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 11:38:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hgbyvx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 11:38:53 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)) 11:38:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 11:38:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 11:38:53 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)) 11:38:53 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)) 11:38:53 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)) 11:38:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 11:38:53 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 11:38:53 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 11:38:54 INFO - Downloading blessings-1.6.tar.gz 11:38:54 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 11:38:54 INFO - Installing collected packages: blessings 11:38:54 INFO - Running setup.py install for blessings 11:38:54 INFO - Successfully installed blessings 11:38:54 INFO - Cleaning up... 11:38:57 INFO - Return code: 0 11:38:57 INFO - Done creating virtualenv C:\slave\test\build/venv. 11:38:57 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 11:38:57 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 11:38:58 INFO - Reading from file tmpfile_stdout 11:38:58 INFO - Using _rmtree_windows ... 11:38:58 INFO - Using _rmtree_windows ... 11:38:58 INFO - Current package versions: 11:38:58 INFO - blessings == 1.6 11:38:58 INFO - blobuploader == 1.2.4 11:38:58 INFO - docopt == 0.6.1 11:38:58 INFO - functools32 == 3.2.3-2 11:38:58 INFO - jsonschema == 2.5.1 11:38:58 INFO - manifestparser == 1.1 11:38:58 INFO - mozInstall == 1.12 11:38:58 INFO - mozcrash == 1.0 11:38:58 INFO - mozdebug == 0.1 11:38:58 INFO - mozdevice == 0.48 11:38:58 INFO - mozfile == 1.2 11:38:58 INFO - mozhttpd == 0.7 11:38:58 INFO - mozinfo == 0.9 11:38:58 INFO - mozleak == 0.1 11:38:58 INFO - mozlog == 3.4 11:38:58 INFO - moznetwork == 0.27 11:38:58 INFO - mozprocess == 0.23 11:38:58 INFO - mozprofile == 0.28 11:38:58 INFO - mozrunner == 6.13 11:38:58 INFO - mozscreenshot == 0.1 11:38:58 INFO - mozsystemmonitor == 0.3 11:38:58 INFO - moztest == 0.7 11:38:58 INFO - mozversion == 1.4 11:38:58 INFO - psutil == 3.1.1 11:38:58 INFO - requests == 1.2.3 11:38:58 INFO - Installing None into virtualenv C:\slave\test\build/venv 11:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:58 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 0x022A8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0284E020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007AE0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02350E90>, '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 0x0071A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023325C0>, '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-100', 'USERDOMAIN': 'T-W864-IX-100', '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-100', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-100', '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-100\\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 11:38:58 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 11:38:58 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 11:38:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:38:58 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Roaming', 11:38:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:38:58 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:38:58 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:38:58 INFO - 'COMPUTERNAME': 'T-W864-IX-100', 11:38:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:38:58 INFO - 'DCLOCATION': 'SCL3', 11:38:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:38:58 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:38:58 INFO - 'HOMEDRIVE': 'C:', 11:38:58 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 11:38:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:38:58 INFO - 'KTS_VERSION': '1.19c', 11:38:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 11:38:58 INFO - 'LOGONSERVER': '\\\\T-W864-IX-100', 11:38:58 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:38:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:58 INFO - 'MOZ_NO_REMOTE': '1', 11:38:58 INFO - 'NO_EM_RESTART': '1', 11:38:58 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:38:58 INFO - 'OS': 'Windows_NT', 11:38:58 INFO - 'OURDRIVE': 'C:', 11:38:58 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:38:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:38:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:38:58 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:38:58 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:38:58 INFO - 'PROCESSOR_LEVEL': '6', 11:38:58 INFO - 'PROCESSOR_REVISION': '1e05', 11:38:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:38:58 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:38:58 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:38:58 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:38:58 INFO - 'PROMPT': '$P$G', 11:38:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:38:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:38:58 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:38:58 INFO - 'PWD': 'C:\\slave\\test', 11:38:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:38:58 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:38:58 INFO - 'SYSTEMDRIVE': 'C:', 11:38:58 INFO - 'SYSTEMROOT': 'C:\\windows', 11:38:58 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:58 INFO - 'TEST1': 'testie', 11:38:58 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:58 INFO - 'USERDOMAIN': 'T-W864-IX-100', 11:38:58 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 11:38:58 INFO - 'USERNAME': 'cltbld', 11:38:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-100', 11:38:58 INFO - 'WINDIR': 'C:\\windows', 11:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:58 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)) 11:38:58 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)) 11:38:58 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)) 11:38:58 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)) 11:38:58 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)) 11:38:58 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)) 11:38:58 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)) 11:38:58 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)) 11:38:58 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)) 11:38:58 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)) 11:38:58 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)) 11:38:58 INFO - Cleaning up... 11:38:58 INFO - Return code: 0 11:38:58 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 11:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:58 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 0x022A8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0284E020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007AE0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02350E90>, '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 0x0071A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023325C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-100', 'USERDOMAIN': 'T-W864-IX-100', '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-100', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-100', '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-100\\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 11:38:58 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 11:38:58 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 11:38:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:38:58 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Roaming', 11:38:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:38:58 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:38:58 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:38:58 INFO - 'COMPUTERNAME': 'T-W864-IX-100', 11:38:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:38:58 INFO - 'DCLOCATION': 'SCL3', 11:38:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:38:58 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:38:58 INFO - 'HOMEDRIVE': 'C:', 11:38:58 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 11:38:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:38:58 INFO - 'KTS_VERSION': '1.19c', 11:38:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 11:38:58 INFO - 'LOGONSERVER': '\\\\T-W864-IX-100', 11:38:58 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:38:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:58 INFO - 'MOZ_NO_REMOTE': '1', 11:38:58 INFO - 'NO_EM_RESTART': '1', 11:38:58 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:38:58 INFO - 'OS': 'Windows_NT', 11:38:58 INFO - 'OURDRIVE': 'C:', 11:38:58 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:38:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:38:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:38:58 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:38:58 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:38:58 INFO - 'PROCESSOR_LEVEL': '6', 11:38:58 INFO - 'PROCESSOR_REVISION': '1e05', 11:38:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:38:58 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:38:58 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:38:58 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:38:58 INFO - 'PROMPT': '$P$G', 11:38:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:38:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:38:58 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:38:58 INFO - 'PWD': 'C:\\slave\\test', 11:38:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:38:58 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:38:58 INFO - 'SYSTEMDRIVE': 'C:', 11:38:58 INFO - 'SYSTEMROOT': 'C:\\windows', 11:38:58 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:58 INFO - 'TEST1': 'testie', 11:38:58 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:38:58 INFO - 'USERDOMAIN': 'T-W864-IX-100', 11:38:58 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 11:38:58 INFO - 'USERNAME': 'cltbld', 11:38:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-100', 11:38:58 INFO - 'WINDIR': 'C:\\windows', 11:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 11:38:58 INFO - Cleaning up... 11:38:58 INFO - Return code: 0 11:38:58 INFO - Running post-action listener: _resource_record_post_action 11:38:58 INFO - Running post-action listener: _start_resource_monitoring 11:38:58 INFO - Starting resource monitoring. 11:38:58 INFO - [mozharness: 2016-11-18 19:38:58.878000Z] Finished create-virtualenv step (success) 11:38:58 INFO - [mozharness: 2016-11-18 19:38:58.879000Z] Running install step. 11:38:58 INFO - Running pre-action listener: _resource_record_pre_action 11:38:58 INFO - Running main action method: install 11:38:58 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 11:38:58 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 11:38:59 INFO - Reading from file tmpfile_stdout 11:38:59 INFO - Using _rmtree_windows ... 11:38:59 INFO - Using _rmtree_windows ... 11:38:59 INFO - Detecting whether we're running mozinstall >=1.0... 11:38:59 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 11:38:59 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 11:38:59 INFO - Reading from file tmpfile_stdout 11:38:59 INFO - Output received: 11:38:59 INFO - Usage: mozinstall-script.py [options] installer 11:38:59 INFO - Options: 11:38:59 INFO - -h, --help show this help message and exit 11:38:59 INFO - -d DEST, --destination=DEST 11:38:59 INFO - Directory to install application into. [default: 11:38:59 INFO - "C:\slave\test"] 11:38:59 INFO - --app=APP Application being installed. [default: firefox] 11:38:59 INFO - Using _rmtree_windows ... 11:38:59 INFO - Using _rmtree_windows ... 11:38:59 INFO - mkdir: C:\slave\test\build\application 11:38:59 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-53.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 11:38:59 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-53.0a1.en-US.win64.zip --destination C:\slave\test\build\application ProcessManager NOT managing child processes 11:39:01 INFO - Reading from file tmpfile_stdout 11:39:01 INFO - Output received: 11:39:01 INFO - C:\slave\test\build\application\firefox\firefox.exe 11:39:01 INFO - Using _rmtree_windows ... 11:39:01 INFO - Using _rmtree_windows ... 11:39:01 INFO - Running post-action listener: _resource_record_post_action 11:39:01 INFO - [mozharness: 2016-11-18 19:39:01.619000Z] Finished install step (success) 11:39:01 INFO - [mozharness: 2016-11-18 19:39:01.619000Z] Running run-tests step. 11:39:01 INFO - Running pre-action listener: _resource_record_pre_action 11:39:01 INFO - Running main action method: run_tests 11:39:01 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 11:39:01 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 11:39:01 INFO - Python 2.7.3 11:39:01 INFO - Return code: 0 11:39:01 INFO - grabbing minidump binary from tooltool 11:39:01 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')]} 11:39:01 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 0x02350E90>, '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 0x0071A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023325C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 11:39:01 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 11:39:01 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 11:39:01 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 11:39:01 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 11:39:01 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpb07lge 11:39:01 INFO - INFO - File integrity verified, renaming tmpb07lge to win32-minidump_stackwalk.exe 11:39:01 INFO - Return code: 0 11:39:01 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 11:39:01 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 11:39:01 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 11:39:01 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 11:39:01 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 11:39:01 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-100', '--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 11:39:01 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Cedar --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-100 --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 11:39:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:39:01 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Roaming', 11:39:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:39:01 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:39:01 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:39:01 INFO - 'COMPUTERNAME': 'T-W864-IX-100', 11:39:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:39:01 INFO - 'DCLOCATION': 'SCL3', 11:39:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:39:01 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:39:01 INFO - 'HOMEDRIVE': 'C:', 11:39:01 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-100', 11:39:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:39:01 INFO - 'KTS_VERSION': '1.19c', 11:39:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-100\\AppData\\Local', 11:39:01 INFO - 'LOGONSERVER': '\\\\T-W864-IX-100', 11:39:01 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 11:39:01 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 11:39:01 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:39:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:02 INFO - 'MOZ_NO_REMOTE': '1', 11:39:02 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 11:39:02 INFO - 'NO_EM_RESTART': '1', 11:39:02 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:39:02 INFO - 'OS': 'Windows_NT', 11:39:02 INFO - 'OURDRIVE': 'C:', 11:39:02 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', 11:39:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:39:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:39:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:39:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:39:02 INFO - 'PROCESSOR_LEVEL': '6', 11:39:02 INFO - 'PROCESSOR_REVISION': '1e05', 11:39:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:39:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:39:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:39:02 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:39:02 INFO - 'PROMPT': '$P$G', 11:39:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:39:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:39:02 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:39:02 INFO - 'PWD': 'C:\\slave\\test', 11:39:02 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 11:39:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:39:02 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:39:02 INFO - 'SYSTEMDRIVE': 'C:', 11:39:02 INFO - 'SYSTEMROOT': 'C:\\windows', 11:39:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:39:02 INFO - 'TEST1': 'testie', 11:39:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:39:02 INFO - 'USERDOMAIN': 'T-W864-IX-100', 11:39:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-100', 11:39:02 INFO - 'USERNAME': 'cltbld', 11:39:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-100', 11:39:02 INFO - 'WINDIR': 'C:\\windows', 11:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:39:02 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-100', '--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 11:39:02 INFO - mozversion application_buildid: 20161118070428 11:39:02 INFO - mozversion application_changeset: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c 11:39:02 INFO - mozversion application_display_name: Nightly 11:39:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:39:02 INFO - mozversion application_name: Firefox 11:39:02 INFO - mozversion application_remotingname: firefox 11:39:02 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 11:39:02 INFO - mozversion application_vendor: Mozilla 11:39:02 INFO - mozversion application_version: 53.0a1 11:39:02 INFO - mozversion platform_buildid: 20161118070428 11:39:02 INFO - mozversion platform_changeset: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c 11:39:02 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 11:39:02 INFO - mozversion platform_version: 53.0a1 11:39:02 INFO - using testdate: 1479497942 11:39:02 INFO - actual date: 1479497942 11:39:02 INFO - starting webserver on 'localhost:49273' 11:39:02 INFO - SUITE-START | Running 2 tests 11:39:02 INFO - TEST-START | dromaeo_css 11:39:02 INFO - operating with platform_type : w8_ 11:39:02 INFO - Initialising browser for dromaeo_css test... 11:39:02 INFO - TEST-INFO | started process 3776 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp7tfe2w\profile http://localhost:49273/getInfo.html) 11:39:10 INFO - PROCESS | 3776 | __metrics Screen width/height:1600/1200 11:39:10 INFO - PROCESS | 3776 | colorDepth:24 11:39:10 INFO - PROCESS | 3776 | Browser inner width/height: 1010/674 11:39:10 INFO - PROCESS | 3776 | __metrics 11:39:12 INFO - PROCESS | 3776 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:39:12 INFO - PROCESS | 3776 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:39:13 INFO - TEST-INFO | 3776: exit 0 11:39:13 INFO - Browser initialized. 11:39:13 INFO - Running cycle 1/1 for dromaeo_css test... 11:39:13 INFO - TEST-INFO | started process 248 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp7tfe2w\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:14 INFO - PROCESS | 248 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 11:39:25 INFO - PROCESS | 248 | RSS: Main: 174358528 11:39:25 INFO - PROCESS | 248 | 11:40:17 INFO - PROCESS | 248 | 1479498017064 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] 11:42:27 INFO - PROCESS | 248 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 11:42:29 INFO - PROCESS | 248 | RSS: Main: 253026304 11:42:29 INFO - PROCESS | 248 | 11:45:32 INFO - PROCESS | 248 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 11:45:32 INFO - PROCESS | 248 | RSS: Main: 228044800 11:45:32 INFO - PROCESS | 248 | 11:48:35 INFO - PROCESS | 248 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 11:48:35 INFO - PROCESS | 248 | RSS: Main: 177127424 11:48:35 INFO - PROCESS | 248 | 11:51:38 INFO - PROCESS | 248 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 11:51:38 INFO - PROCESS | 248 | RSS: Main: 176132096 11:51:38 INFO - PROCESS | 248 | 11:54:42 INFO - PROCESS | 248 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 11:54:42 INFO - PROCESS | 248 | RSS: Main: 164179968 11:54:42 INFO - PROCESS | 248 | 11:57:45 INFO - PROCESS | 248 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 11:57:46 INFO - PROCESS | 248 | RSS: Main: 213385216 11:57:46 INFO - PROCESS | 248 | 11:57:46 INFO - PROCESS | 248 | __start_tp_report 11:57:46 INFO - PROCESS | 248 | _x_x_mozilla_page_load 11:57:46 INFO - PROCESS | 248 | _x_x_mozilla_page_load_details 11:57:46 INFO - PROCESS | 248 | |i|pagename|runs| 11:57:46 INFO - PROCESS | 248 | |0;dojo.html;2610.4126571521406;2650.045983445958;2650.3374156460886;2665.9600105998416;2683.2084535062154;4350.195213885429;4354.107407981364;4399.428074350334;4405.933910991338;4448.266036104047;4278.550752171024;4368.19188450137;4403.515613282544;4419.116176764644;4463.754493502856;3984.681225501967;4016.7389119707127;4042.595740425956;4050.6759459243335;4095.283325418055;4012.498437695288;4020.6984476164257;4073.796310184479;4090.1615168890453;4128.731632443896;724.6940444188126;4037.576054514278;4078.653314468259;4112.856050038235;4133.483314585676;3851.749636273661;3984.9601503984877;4011.6389524942897;4031.9193616127513;4044.170944956277;3925.8625948091967;4001.239764444746;4021.3967904814513;4023.5775243599587;4071.877843664695;4323.1785960667685;4357.455318085239;4380.934285985712;4393.978030109861;4439.956610196601;4501.594856462934;4523.683342166017;4558.931616025762;4560.110778398213;4565.315202719586;4544.750038747868;4615.699979501322;4616.163019107541;4620.953790462086;4664.906701865943;4261.31818908973;4270.893227669333;4293.3130699088;4294.828206871753;4330.826766929287;4575.382323386367;4639.095376401637;4644.767761611974;4661.603763680125;4668.996165824364;4554.362389265505;4605.0099228665995;4608.539146085364;4633.513481084505;4647.837325693652;4646.605038571759;4650.697704649187;4671.065786842645;4675.018246168274;4719.551642593948;4429.911401771947;4484.910301793946;4641.95358046422;4650.697704649187;4678.298255261738;4498.662600304925;4520.4801447833925;4553.2942393929;4627.213373726475;4635.976820115878;3162.067190178857;3166.4458719723957;3166.60417447819;3184.188032051812;3196.0411876436974;2984.19426754775;2987.8207307561615;3000.834954077503;3011.728944394971;3014.110837303001;4234.957650423518;4243.3634954757035;4255.063885945149;4303.806328715215;4309.612134907873;4525.864224073283;4533.523979982055;4551.089782043605;4567.337736028324;4586.0827834432575;4258.595433433881;4259.339802330582;4262.2754131797665;4306.547812479707;4319.136172765459;3825.5791862895057;3850.403187505941;3850.7497012694084;3856.768593884376;3892.260470510594;4569.474510431343;4602;4660.904687398391;4674.368960190331;4681.953180468152;4596.241620132774;4597.195490789031;4612.100640375094;4622.699524530894;4623.283391074388;4664.300354946649;4672.205725026822;4713.057388522241;4721.858344249678;4796.37647105874;4591.03588246472;4643.651726120622;4648.83729069481;4677.836275730333;4680.642613642006;4630.814767409401;4683.906321873612;4690;4692.6480513960905;4745.620350372031;4409.713368631029;4457.68796184264;4550.453945526558;4580.702254353457;4593.517680643485;4562.361269422217;4580.152671755736;4615.78287102489;4648.535146485325;4657.906841863211;4506.301523263899;4544.431946006749;4550.795214215302;4581.656375771764;4594.678372513892;4372.80322385487;4472.843450479218;4550.522195169459;4552.430946131733;4638.234691275901;4546.88632784183;4574.0165864338;4585.174668559691;4604.148232576984;4607.14767767964 11:57:46 INFO - PROCESS | 248 | |1;ext.html;554.7891801115576;554.9916751248732;562.8208902349579;567.1775924908883;580.1066357808975;24853.751462485394;26835;26860.05989790358;34846.651533484655;36835.631643683555;36964.26071478569;37489.62510374896;37568;37572.81213593928;37577;7423.814404639887;7538.736144234953;7539.585322807244;7564.697412103509;7570.05374328209;7019.649017549128;7211.206767255598;7215.206327303992;7299.598522081284;7390.29792169743;7315.56106633601;7379.372753315948;8541.846850675172;8766.079561646031;8827.646894124227;9016.684416045473;9059.547022648841;9105.271578273721;9111.27109831212;9135.995040545567;9025.458472491606;9036.909630903672;9076.8638470423;9099.408538444979;9106.590203440861;26895.32761680954;27688.169354919384;27785.583216251773;29703.405931881458;32618.6738132618;3010.292581243406;3104.6584875663657;3139.0582825152364;3320.4023275810346;3485.8082805445692;25490;25752.613710794354;25821;25826.225213243633;26588.335291617863;3432.7940323580665;3441.174118211636;3449.741269404805;3475.826208689555;3497.178163131662;196578;196607;196623;197076;197114;46809.531904680516;46849.29726054112;47036.29445558319;47149.76425117921;47169.29246061312;43845.561544384145;48175.75912120487;49016.264756028686;50261.497385026414;50263;12189.451474683661;12837;12861.485540578458;12872.420741066675;12934.741305174031;9427.717168484956;9934.602615895283;9978.251631127694;9984.750381240381;9986.700398988041;13253.867461325457;14453.85546144546;14512.782308265385;14594;14628.926855365868;4944.851654450372;5828.6211396259105;5956.315023772235;6042.154098426224;6059.666718330534;824.1511243419287;826.4834478450969;885.588201486312;886.7871710789493;962.7820806679556;25846.22461326163;26010.479790404086;26193.083242086817;26433;26508.734912651013;949.7530642032983;950.9096635819586;963.0995019656643;971.0920289529313;979.9216062714966;13389.330533473287;13751.862481375258;13856.653583660287;13987.160770353812;14005.159690418608;276329;277291;277899;278718;278876;40546.39180412296;41569.792151039655;45152.54847451549;46885.29672054922;46989.060218795436;1183.1363104933446;1197.2577002258656;1215.8419405477232;1217.117589747426;1220.737541428597;26459.338516537242;27077.323066923484;27201.72798271992;27272.181834544994;27526.311842204104;41436.792816036934;41582.37626435545;41904.79047604864;42064.78967605143;42086.1582768349;279842;362694;364436;365007;365999;22653.660195096756;22812.885935570215;22837.543249135255;22896;22920.19779307716;36892;37231.81384093062;37232;37329.62670373262;37390.25219495541;31786.841065794524;31962.68037319597;32339.514907275938;32485.18787030343;32837;30863.382732344777;31808.522872156474;32127.839360803046;32220.516692250105;32384.67615323911;30861.228469288446;31389.686103138676;31537;31672.683273166975;31769.888053918003;27443.31391715223;28836.855815721625;28951.118177318407;28966.13101606955;29082.27294317659;22598.209062682727;23024.539509210055;23115.190968316027;23290;23321.883390582938 11:57:46 INFO - PROCESS | 248 | |2;jquery.html;318.0585467017628;330.3986744125692;337.1806510180262;338.48043253605715;355.2007982040409;11999.460024298905;13044.804327935077;14853.925730371333;15458.536243912673;16615.750763738524;12886.162399444052;13015.609531714064;13134.60596182116;13760.862391376084;15118.47085352013;4715.882102947419;4933.531314525115;4934.407871055479;4937.160682683934;4937.5556199942;4785.521447855222;4945.159322915113;4956.2070068789;4980.053789779949;4983.227599722049;4914.459409464956;4928.482509336522;4940.357753492059;4940.40715114185;4951.8019279228965;4600.907981840378;4761.381020467317;4877.6829506081995;4927.1377508935975;4930.087933732253;4765.571098601108;4792.760361981887;4796.400449943757;4799.352087468182;4799.808007679689;10813.459327033617;10860.67417977462;10901.890981090168;11016.504257308441;11033.282836615675;1806.9096545172688;1822.1435925115175;1835.1741716227618;1852.435007322766;2001.3395579458888;7644.235576442366;8378.581070946428;8457.492550446992;10996.835047474295;12159.38573206756;1509.3811537269667;1573.67739613379;1621.9594510137224;1628.7068327701008;1673.0547240808903;56333;57308.42691573114;58517;59346;61410.692946535426;8676.69631562905;8766.91233087661;9125;9201.539923003824;9279.860802087975;12455.626331210078;12474.376281185905;12480.126391152713;12480.563180288646;12483;6079.240094988127;6266.624002559861;6311.211098612674;6331.588446751039;6351.841203969938;5586.608937374344;5750.3099628044065;5791.247137872049;5854;5863.237779088691;3912.374020156761;3956.4263181839046;3985.601439855991;4030.8186131624147;4030.8790736277374;1615.1278309712623;1645.6708658268394;1664.0764375771564;1668.8247733987998;1722.3799432204396;822.457178262344;884.5798245833178;913.2602591900448;915.9267258619294;939.0750111140658;15378.538643840702;15454.459093931659;15543.611409714847;15664;16040.518784436486;806.2544590960505;822.6709316273419;827.8882350882674;843.6245870587529;856.0455092571862;8600.354973377021;8662.91337086621;8952.507612081397;8965.148310910454;9090.36367454285;208207;268537;270547;271481;280491;64104.35895640984;66145;66592;67766.32233677698;68100.6594967022;834.7620928035602;880.2341962492673;880.8282384934876;881.5107615273456;884.186548375496;13800.240986745424;14073.155610663393;14146.858531414966;14155.609407277863;14396;27839.721602783713;27992.720072799824;28757.28106797347;29977.550336745404;31927.6807231934;37443.62556374401;38027.42958855675;39691.603083969945;40614.1877162461;41769.79115104405;5937.317208521075;6174.197354343906;6505.2844187138435;6860.519763616699;7085.468589855678;10417.16662667;10955.890441095487;11081.944590276997;11095.223334366518;11125.777484450104;9028.503432311287;9130.132637399436;9185.816283674423;9213.355065145375;9545;4259.318509038539;9392;9435.622575096919;9529.285303602119;9560.66537671206;9095.636174553209;9381.249500040118;9505.382150160218;9516.143547080796;9656;6432.195975503062;6460.838479038061;6554.737810487718;6566.671666416755;6606.6036037837885;8600.78498037554;9245.72262832116;9320.300977426856;9374.578143983674;9516.809663806547 11:57:46 INFO - PROCESS | 248 | |3;mootools.html;1120.3278033180088;1262.7158889249918;1297.3318740848465;1309.1948451702203;1561.7501199808032;5637.351704553972;6186.443220110189;6428.742850285983;6437;6584.144061272028;6422.775202867901;6487.156669632953;6493.577917435376;6500.187476565429;6511.4465270452065;1895.9146838392305;1929.257235964157;1937.3897222374978;1938.331275709878;1940.3014914630721;1877.8309952104307;1900.7053906644423;1908.1604094198578;1920.049575460149;1935.1872213670292;1903.1626084522834;1918.7505624268827;1921.8750781199246;1923.8749481283742;1924.2976313645488;1752.6494701059776;1790.0691640347077;1797.63148554546;1797.739327797462;1799.370220422848;1842.4472658202485;1851.3427733154672;1868;1868.7757469103658;1882.0119437295393;6405.19935008124;6429.4534964528075;6472.417482426604;6475.611463312216;6671.699773510204;3814.90462738431;3914.0997570558648;3916.4321173429694;3920.2943470175355;3929.4105884117325;2333.428310064045;2366.668666386707;2383.6782034425305;2387.6418537219383;2389.9163529276393;725.8512005038955;752.2101793117259;753.186558516806;768.0476209500235;769.8999130113106;8678.088800675901;8730.781730456725;8741.650333986696;8801.383903126783;8804.823903521958;3375.375555522236;3448.948070838368;3513.5959364672876;3515.7519080726483;3520.2607452435277;7150.356467917808;7169.103862017248;7171.318724721144;7174.605396703127;7192.208857025723;3954.822033008464;4022.9942514371405;4025.899352516152;4029.979850100731;4030.214108248922;3100.3024319527926;3234.886778962725;3782.6217378261954;3784.5836957934607;3789.77261364319;2958.7337139657534;3075.261937135116;3088.7992280502144;3104.0532637545766;3122.672119427473;820.6143112737004;826.2893911236332;829.1915382502133;848.1476116502876;850.2985037344092;690.8963655451722;733.1495465260273;803.2850762821093;827.1521690267524;830.0851382071916;4315.223259813264;4386.188555117314;4457.175422546839;4462.799174037176;4479.686421950498;770.3567521119928;772.5982489105634;860.1355637584313;883.4186805618;906.2025417632441;2888.7400133988044;3021.531662592302;3068.785185037026;3113.5018397056815;3148.7323577495713;7187.245339239409;7589.962050189713;7593.924060759322;7653.311201991847;8080.595970201584;7702.499337543042;7746.38028957682;7759.495632783964;7761.61191940412;7765;6052.092186172109;6150.07748837669;6209.59637623553;6219.937800621936;6223.688815559204;4457.732536047847;4460.509343972225;4461.397711308931;4619.214733495247;4808.3989501312335;7055;7083.2208457068655;7200.855982880418;7237.276272372721;7257.419406447577;7292.598907060163;7298.96350518244;7301.488895777245;7346.302101300368;7413.443991700752;5816.1857339973285;5961.165436838759;6015.496125968508;6026.849328766641;6043.879122417439;5407.161889907071;5610.803621873215;6009.278886533644;6182.598131121463;6230.283517395557;5693.28833895763;5700.515456186271;5710.972025035533;5761.769529218952;5868;5388.084025715716;5453.863653408696;5489;5531.280933478622;5724;5388.838334849961;5399.190121481809;5445.183222516495;5453.563714902719;5460.808871689472;3881.7670939743707;3944.309745794532;3977.8209980550364;4014.0366312085475;4042.1915616876154;3684.3736564783517;3721.9069523262133;3825.349690552557;3845.3462911304587;3873.4770805941967 11:57:46 INFO - PROCESS | 248 | |4;prototype.html;262.92638061342825;265.97074321824596;266.7132832205379;270.4212984213783;272.88538813698244;4609.354690343351;4625.375574297469;4634.397528321322;4641.814327426899;4676.228422310323;4564.634829213664;4594.425696787902;4594.632429405648;4596.977015114928;4599.40207772989;3395.3718562066033;3478.5999610044914;3512.6487351264923;3551.769135006229;3576.3741345264607;3552.325058238939;3569.660882216185;3570.8930231628146;3579.192507783566;3582.3372676054883;3550.7217401735356;3560.5935655416097;3563.6436356364416;3570;3599.938018284612;3394.7778799632115;3464.4110501214855;3503.6496350365014;3509.7891227526716;3531;3036.2561172512656;3040.148758347666;3042.3763128558594;3044.9391012179854;3050.9542356864663;4471.757975467793;4481;4497.7526236057;4514.300283456037;4514.593686568224;3837.347650899326;3881.611838816124;3947.210557888434;3959.148783011666;3971.2653159165648;4660.743659098748;4695.859124226278;4698.624110071186;4717.811287548494;4731.834385796515;3261.168402057484;3283.228441316289;3283.7537184711005;3287.2767991041933;3301.042697617688;4914.3901452546625;4922.941567562955;4926.236433352836;4941.283513890466;4945.184044632631;3257.2833976525126;3337.399268131711;3357.942248191812;3376.3922493951322;3377;3396.4735466002808;3401.897943061712;3403.7447191460737;3414.1123307940115;3414.1293970037977;3910.4720862683175;3914.1780226152828;3927.684225784394;3931.3709806430834;3932.4297976793778;4704.435467743824;4720.834770783006;4723.078999595046;4724.834630787906;4733.2900064989835;1119.7592517608753;1177.1348059176498;1178.0987544528443;1184.4788293150987;1195.8804119587971;755.7959350975206;803.4335793265734;806.1696452653777;808.7113468883164;811.4968719394013;4311.827526898889;4339.652827773771;4354.586314300136;4361.899814174666;4388.27593447084;4790.377250957423;4893.6329775266995;4926.45808961014;4939.431965323962;4952.455229924705;4547.181507328646;4574.862754117382;4576.588107070313;4587.8623641290815;4588.747618880993;2387.6179811230118;2493.364192130995;2507.4734305795987;2508.849469031864;2524.129175434472;4772.522747725269;4778.880527986828;4795.496472870368;4799.496052914464;4804.639652026042;4780.593649539828;4813.098825963724;4826.444958829709;4829.806807727722;4852.611791056707;4462.831260677841;4711.45818230901;4740.45484769249;4749.881252968704;4810.278458231293;4739.312799643963;4739.611178007741;4740.762961851962;4745.952540474689;4748.952510474989;4559.817607295671;4644.117617652635;4646.395968524071;4667.276572131325;4687;4718.31584420264;4821.07157137148;5033.92449113271;5049.772760225872;5050.545450909436;3326.3513614844874;3342.431786596333;3347.9665203347654;3351.7653764237243;3361.3949489092197;4936.407631084149;4940.086084074458;4963.602911767122;4972.825951091694;4984.2025275955675;4608.2166031774;4827.08285425768;4843.321934929042;4846.418429788448;4857.2714092884935;4812.51874812516;4819.397575303087;4847.757612119451;4859;4860.343853579863;4755.714657120584;4774.1883879739835;4790.185668436305;4794.904101918012;4802.855914322576;4656.650751193606;4835.540623640749;4876.634252431011;4879.487653796442;4908.950910490849;4805.9038819224115;4812.446568644651;4817.855464336076;4818.759062046814;4832.565069143794 11:57:46 INFO - PROCESS | 248 | |5;yui.html;619.8853212155751;621.2762132116085;643.5302229372561;698.7379732600275;710.2719712294897;11235.550577976881;11923.28460292383;12068.637940861767;12072.39638018099;12709.110362274645;11354.772904541904;11700.239484433527;11707.707307317321;11717.121215908819;11737.29576225427;606.1695477196225;741.0033504935852;749.7863109013932;751.8421131562351;752.259024860512;598.9700514974255;725.0827702955766;746.947713660044;752.2327226229243;756.8524137793132;787.8030492376906;789.5223389849116;791.4538968111984;792.188007292524;792.579932635704;628.7924984755019;780.6057940739947;784.1100351101484;784.4508843809327;784.4900814470583;481.4944308476086;555.4306835493611;570.4124751505956;573.4093883300166;576.0408919149611;11548.191626586142;11577.6526704199;11597.942010289978;11629.651110466615;11656.067514598812;10728.195385346053;10851.728706782314;10914.890851091466;11014.284071535405;11358.091352691765;10473.633422830164;10485.9475702621;10494.79010419795;10533.631322903739;10629.787404251949;3090.644575873781;3221.6617255188335;3323.11937336606;3793.8292776824833;3799.67702745267;43234.78382608067;43709.78145109286;43989.12021759579;44319.556804431864;44643;8742.25690816275;8782.42914210587;8941.105889411007;9024.819503609891;9098.545072746336;15022.323995420233;15030.624234394227;15042.623934401727;15048.247587620794;15059.623509412133;5929.407059294036;5961.731722072517;6031.60794548353;6038.939610603926;6228.47058000066;3465.653434656514;3470.687638112582;3475.982620086934;3507.1232191952013;3574.8212589370946;2306.261996161212;2381.6189409694366;2405.927822165303;2412.8672922989053;2414.360194548446;399.62435310807746;407.8796754957295;408.03906799487373;409.3654835005729;412.2579357157105;501.39832201358513;501.4208589079619;503.18735242582966;521.2520033751503;527.6385675812081;6696.933030669728;6715.160604924385;6874.793756187322;6903.403023032896;7052.92947070533;542.3437640455094;557.4363909234636;572.5362456410321;575.6689903305617;589.107502134267;3520.2079532105586;3641.707193946164;3665.248624032067;3748.2878253131817;3804.334241507725;58246.70876645589;58810.41189588135;61784.38215617876;62160.378396216365;62376.688116559126;52782;54007;55357.446425536036;55895.72052139713;55946.440535594935;48912.510874890795;49000.75499622551;49196.75401622969;49356;50276.748616256686;6963.850964590786;7284.49008569395;7343.632818359168;7471.813204669927;7478.102627684712;31581.526277105404;32431.189220269684;32534.837325814166;32572;33418.83290583629;27818.44363112767;40123.59876401316;40632.59367406406;44301.33547996847;45471.044382115055;9412.152906238198;9582.568784404579;9611.279154063333;9619.134277915022;9723;10749.462526873782;10868.836967445653;10991.395473249047;11368.147388946027;11403.429828508708;8984.640614375352;9074.092590740873;9622.759431014001;9643.855342170013;9763;9851.655192068243;9879.555420006262;9886.802263954825;9999.500024998575;10013.098821106136;9313.813723725352;9513.904860951301;9587.376820506644;9662.3719458235;9895;8426.620802063799;8528.189821966904;8844.380893337662;8860.911390886009;9005.05446928063;8470.618822153141;8568.228859402683;8688.304935605263;8750.212480876751;8770.561471926505 11:57:46 INFO - PROCESS | 248 | __end_tp_report 11:57:46 INFO - PROCESS | 248 | __start_cc_report 11:57:46 INFO - PROCESS | 248 | _x_x_mozilla_cycle_collect,1357 11:57:46 INFO - PROCESS | 248 | __end_cc_report 11:57:46 INFO - PROCESS | 248 | __startTimestamp1479499066051__endTimestamp 11:57:46 INFO - PROCESS | 248 | 11:57:46 INFO - PROCESS | 248 | ------- Summary: start ------- 11:57:46 INFO - PROCESS | 248 | Number of tests: 6 11:57:46 INFO - PROCESS | 248 | 11:57:46 INFO - PROCESS | 248 | [#0] dojo.html Cycles:165 Average:4274.32 Median:4506.30 stddev:566.97 (12.6%) stddev-sans-first:553.48 11:57:46 INFO - PROCESS | 248 | Values: 2610.4 2650.0 2650.3 2666.0 2683.2 4350.2 4354.1 4399.4 4405.9 4448.3 4278.6 4368.2 4403.5 4419.1 4463.8 3984.7 4016.7 4042.6 4050.7 4095.3 4012.5 4020.7 4073.8 4090.2 4128.7 724.7 4037.6 4078.7 4112.9 4133.5 3851.7 3985.0 4011.6 4031.9 4044.2 3925.9 4001.2 4021.4 4023.6 4071.9 4323.2 4357.5 4380.9 4394.0 4440.0 4501.6 4523.7 4558.9 4560.1 4565.3 4544.8 4615.7 4616.2 4621.0 4664.9 4261.3 4270.9 4293.3 4294.8 4330.8 4575.4 4639.1 4644.8 4661.6 4669.0 4554.4 4605.0 4608.5 4633.5 4647.8 4646.6 4650.7 4671.1 4675.0 4719.6 4429.9 4484.9 4642.0 4650.7 4678.3 4498.7 4520.5 4553.3 4627.2 4636.0 3162.1 3166.4 3166.6 3184.2 3196.0 2984.2 2987.8 3000.8 3011.7 3014.1 4235.0 4243.4 4255.1 4303.8 4309.6 4525.9 4533.5 4551.1 4567.3 4586.1 4258.6 4259.3 4262.3 4306.5 4319.1 3825.6 3850.4 3850.7 3856.8 3892.3 4569.5 4602.0 4660.9 4674.4 4682.0 4596.2 4597.2 4612.1 4622.7 4623.3 4664.3 4672.2 4713.1 4721.9 4796.4 4591.0 4643.7 4648.8 4677.8 4680.6 4630.8 4683.9 4690.0 4692.6 4745.6 4409.7 4457.7 4550.5 4580.7 4593.5 4562.4 4580.2 4615.8 4648.5 4657.9 4506.3 4544.4 4550.8 4581.7 4594.7 4372.8 4472.8 4550.5 4552.4 4638.2 4546.9 4574.0 4585.2 4604.1 4607.1 11:57:46 INFO - PROCESS | 248 | 11:57:46 INFO - PROCESS | 248 | [#1] ext.html Cycles:180 Average:41510.65 Median:3462.78 stddev:74131.77 (2140.8%) stddev-sans-first:74275.95 11:57:46 INFO - PROCESS | 248 | Values: 554.8 555.0 562.8 567.2 580.1 24853.8 26835.0 26860.1 34846.7 36835.6 36964.3 37489.6 37568.0 37572.8 37577.0 7423.8 7538.7 7539.6 7564.7 7570.1 7019.6 7211.2 7215.2 7299.6 7390.3 7315.6 7379.4 8541.8 8766.1 8827.6 9016.7 9059.5 9105.3 9111.3 9136.0 9025.5 9036.9 9076.9 9099.4 9106.6 26895.3 27688.2 27785.6 29703.4 32618.7 3010.3 3104.7 3139.1 3320.4 3485.8 25490.0 25752.6 25821.0 25826.2 26588.3 3432.8 3441.2 3449.7 3475.8 3497.2 196578.0 196607.0 196623.0 197076.0 197114.0 46809.5 46849.3 47036.3 47149.8 47169.3 43845.6 48175.8 49016.3 50261.5 50263.0 12189.5 12837.0 12861.5 12872.4 12934.7 9427.7 9934.6 9978.3 9984.8 9986.7 13253.9 14453.9 14512.8 14594.0 14628.9 4944.9 5828.6 5956.3 6042.2 6059.7 824.2 826.5 885.6 886.8 962.8 25846.2 26010.5 26193.1 26433.0 26508.7 949.8 950.9 963.1 971.1 979.9 13389.3 13751.9 13856.7 13987.2 14005.2 276329.0 277291.0 277899.0 278718.0 278876.0 40546.4 41569.8 45152.5 46885.3 46989.1 1183.1 1197.3 1215.8 1217.1 1220.7 26459.3 27077.3 27201.7 27272.2 27526.3 41436.8 41582.4 41904.8 42064.8 42086.2 279842.0 362694.0 364436.0 365007.0 365999.0 22653.7 22812.9 22837.5 22896.0 22920.2 36892.0 37231.8 37232.0 37329.6 37390.3 31786.8 31962.7 32339.5 32485.2 32837.0 30863.4 31808.5 32127.8 32220.5 32384.7 30861.2 31389.7 31537.0 31672.7 31769.9 27443.3 28836.9 28951.1 28966.1 29082.3 22598.2 23024.5 23115.2 23290.0 23321.9 11:57:46 INFO - PROCESS | 248 | 11:57:46 INFO - PROCESS | 248 | [#2] jquery.html Cycles:180 Average:18639.05 Median:4929.29 stddev:43619.01 (884.9%) stddev-sans-first:43719.68 11:57:46 INFO - PROCESS | 248 | Values: 318.1 330.4 337.2 338.5 355.2 11999.5 13044.8 14853.9 15458.5 16615.8 12886.2 13015.6 13134.6 13760.9 15118.5 4715.9 4933.5 4934.4 4937.2 4937.6 4785.5 4945.2 4956.2 4980.1 4983.2 4914.5 4928.5 4940.4 4940.4 4951.8 4600.9 4761.4 4877.7 4927.1 4930.1 4765.6 4792.8 4796.4 4799.4 4799.8 10813.5 10860.7 10901.9 11016.5 11033.3 1806.9 1822.1 1835.2 1852.4 2001.3 7644.2 8378.6 8457.5 10996.8 12159.4 1509.4 1573.7 1622.0 1628.7 1673.1 56333.0 57308.4 58517.0 59346.0 61410.7 8676.7 8766.9 9125.0 9201.5 9279.9 12455.6 12474.4 12480.1 12480.6 12483.0 6079.2 6266.6 6311.2 6331.6 6351.8 5586.6 5750.3 5791.2 5854.0 5863.2 3912.4 3956.4 3985.6 4030.8 4030.9 1615.1 1645.7 1664.1 1668.8 1722.4 822.5 884.6 913.3 915.9 939.1 15378.5 15454.5 15543.6 15664.0 16040.5 806.3 822.7 827.9 843.6 856.0 8600.4 8662.9 8952.5 8965.1 9090.4 208207.0 268537.0 270547.0 271481.0 280491.0 64104.4 66145.0 66592.0 67766.3 68100.7 834.8 880.2 880.8 881.5 884.2 13800.2 14073.2 14146.9 14155.6 14396.0 27839.7 27992.7 28757.3 29977.6 31927.7 37443.6 38027.4 39691.6 40614.2 41769.8 5937.3 6174.2 6505.3 6860.5 7085.5 10417.2 10955.9 11081.9 11095.2 11125.8 9028.5 9130.1 9185.8 9213.4 9545.0 4259.3 9392.0 9435.6 9529.3 9560.7 9095.6 9381.2 9505.4 9516.1 9656.0 6432.2 6460.8 6554.7 6566.7 6606.6 8600.8 9245.7 9320.3 9374.6 9516.8 11:57:46 INFO - PROCESS | 248 | 11:57:46 INFO - PROCESS | 248 | [#3] mootools.html Cycles:180 Average:4272.81 Median:5453.71 stddev:2315.00 (42.4%) stddev-sans-first:2309.37 11:57:46 INFO - PROCESS | 248 | Values: 1120.3 1262.7 1297.3 1309.2 1561.8 5637.4 6186.4 6428.7 6437.0 6584.1 6422.8 6487.2 6493.6 6500.2 6511.4 1895.9 1929.3 1937.4 1938.3 1940.3 1877.8 1900.7 1908.2 1920.0 1935.2 1903.2 1918.8 1921.9 1923.9 1924.3 1752.6 1790.1 1797.6 1797.7 1799.4 1842.4 1851.3 1868.0 1868.8 1882.0 6405.2 6429.5 6472.4 6475.6 6671.7 3814.9 3914.1 3916.4 3920.3 3929.4 2333.4 2366.7 2383.7 2387.6 2389.9 725.9 752.2 753.2 768.0 769.9 8678.1 8730.8 8741.7 8801.4 8804.8 3375.4 3448.9 3513.6 3515.8 3520.3 7150.4 7169.1 7171.3 7174.6 7192.2 3954.8 4023.0 4025.9 4030.0 4030.2 3100.3 3234.9 3782.6 3784.6 3789.8 2958.7 3075.3 3088.8 3104.1 3122.7 820.6 826.3 829.2 848.1 850.3 690.9 733.1 803.3 827.2 830.1 4315.2 4386.2 4457.2 4462.8 4479.7 770.4 772.6 860.1 883.4 906.2 2888.7 3021.5 3068.8 3113.5 3148.7 7187.2 7590.0 7593.9 7653.3 8080.6 7702.5 7746.4 7759.5 7761.6 7765.0 6052.1 6150.1 6209.6 6219.9 6223.7 4457.7 4460.5 4461.4 4619.2 4808.4 7055.0 7083.2 7200.9 7237.3 7257.4 7292.6 7299.0 7301.5 7346.3 7413.4 5816.2 5961.2 6015.5 6026.8 6043.9 5407.2 5610.8 6009.3 6182.6 6230.3 5693.3 5700.5 5711.0 5761.8 5868.0 5388.1 5453.9 5489.0 5531.3 5724.0 5388.8 5399.2 5445.2 5453.6 5460.8 3881.8 3944.3 3977.8 4014.0 4042.2 3684.4 3721.9 3825.3 3845.3 3873.5 11:57:46 INFO - PROCESS | 248 | 11:57:46 INFO - PROCESS | 248 | [#4] prototype.html Cycles:180 Average:3962.80 Median:4598.19 stddev:1182.39 (25.7%) stddev-sans-first:1152.63 11:57:46 INFO - PROCESS | 248 | Values: 262.9 266.0 266.7 270.4 272.9 4609.4 4625.4 4634.4 4641.8 4676.2 4564.6 4594.4 4594.6 4597.0 4599.4 3395.4 3478.6 3512.6 3551.8 3576.4 3552.3 3569.7 3570.9 3579.2 3582.3 3550.7 3560.6 3563.6 3570.0 3599.9 3394.8 3464.4 3503.6 3509.8 3531.0 3036.3 3040.1 3042.4 3044.9 3051.0 4471.8 4481.0 4497.8 4514.3 4514.6 3837.3 3881.6 3947.2 3959.1 3971.3 4660.7 4695.9 4698.6 4717.8 4731.8 3261.2 3283.2 3283.8 3287.3 3301.0 4914.4 4922.9 4926.2 4941.3 4945.2 3257.3 3337.4 3357.9 3376.4 3377.0 3396.5 3401.9 3403.7 3414.1 3414.1 3910.5 3914.2 3927.7 3931.4 3932.4 4704.4 4720.8 4723.1 4724.8 4733.3 1119.8 1177.1 1178.1 1184.5 1195.9 755.8 803.4 806.2 808.7 811.5 4311.8 4339.7 4354.6 4361.9 4388.3 4790.4 4893.6 4926.5 4939.4 4952.5 4547.2 4574.9 4576.6 4587.9 4588.7 2387.6 2493.4 2507.5 2508.8 2524.1 4772.5 4778.9 4795.5 4799.5 4804.6 4780.6 4813.1 4826.4 4829.8 4852.6 4462.8 4711.5 4740.5 4749.9 4810.3 4739.3 4739.6 4740.8 4746.0 4749.0 4559.8 4644.1 4646.4 4667.3 4687.0 4718.3 4821.1 5033.9 5049.8 5050.5 3326.4 3342.4 3348.0 3351.8 3361.4 4936.4 4940.1 4963.6 4972.8 4984.2 4608.2 4827.1 4843.3 4846.4 4857.3 4812.5 4819.4 4847.8 4859.0 4860.3 4755.7 4774.2 4790.2 4794.9 4802.9 4656.7 4835.5 4876.6 4879.5 4909.0 4805.9 4812.4 4817.9 4818.8 4832.6 11:57:46 INFO - PROCESS | 248 | 11:57:46 INFO - PROCESS | 248 | [#5] yui.html Cycles:180 Average:12987.30 Median:27956.44 stddev:16236.36 (58.1%) stddev-sans-first:16255.35 11:57:46 INFO - PROCESS | 248 | Values: 619.9 621.3 643.5 698.7 710.3 11235.6 11923.3 12068.6 12072.4 12709.1 11354.8 11700.2 11707.7 11717.1 11737.3 606.2 741.0 749.8 751.8 752.3 599.0 725.1 746.9 752.2 756.9 787.8 789.5 791.5 792.2 792.6 628.8 780.6 784.1 784.5 784.5 481.5 555.4 570.4 573.4 576.0 11548.2 11577.7 11597.9 11629.7 11656.1 10728.2 10851.7 10914.9 11014.3 11358.1 10473.6 10485.9 10494.8 10533.6 10629.8 3090.6 3221.7 3323.1 3793.8 3799.7 43234.8 43709.8 43989.1 44319.6 44643.0 8742.3 8782.4 8941.1 9024.8 9098.5 15022.3 15030.6 15042.6 15048.2 15059.6 5929.4 5961.7 6031.6 6038.9 6228.5 3465.7 3470.7 3476.0 3507.1 3574.8 2306.3 2381.6 2405.9 2412.9 2414.4 399.6 407.9 408.0 409.4 412.3 501.4 501.4 503.2 521.3 527.6 6696.9 6715.2 6874.8 6903.4 7052.9 542.3 557.4 572.5 575.7 589.1 3520.2 3641.7 3665.2 3748.3 3804.3 58246.7 58810.4 61784.4 62160.4 62376.7 52782.0 54007.0 55357.4 55895.7 55946.4 48912.5 49000.8 49196.8 49356.0 50276.7 6963.9 7284.5 7343.6 7471.8 7478.1 31581.5 32431.2 32534.8 32572.0 33418.8 27818.4 40123.6 40632.6 44301.3 45471.0 9412.2 9582.6 9611.3 9619.1 9723.0 10749.5 10868.8 10991.4 11368.1 11403.4 8984.6 9074.1 9622.8 9643.9 9763.0 9851.7 9879.6 9886.8 9999.5 10013.1 9313.8 9513.9 9587.4 9662.4 9895.0 8426.6 8528.2 8844.4 8860.9 9005.1 8470.6 8568.2 8688.3 8750.2 8770.6 11:57:46 INFO - PROCESS | 248 | -------- Summary: end -------- 11:57:46 INFO - PROCESS | 248 | 11:57:46 INFO - TEST-INFO | 248: exit 0 11:57:47 INFO - TEST-OK | dromaeo_css | took 1124644ms 11:57:47 INFO - TEST-START | kraken 11:57:47 INFO - operating with platform_type : w8_ 11:57:47 INFO - Initialising browser for kraken test... 11:57:47 INFO - TEST-INFO | started process 3140 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpp31dob\profile http://localhost:49273/getInfo.html) 11:57:53 INFO - PROCESS | 3140 | __metrics Screen width/height:1600/1200 11:57:53 INFO - PROCESS | 3140 | colorDepth:24 11:57:53 INFO - PROCESS | 3140 | Browser inner width/height: 1010/674 11:57:53 INFO - PROCESS | 3140 | __metrics 11:57:54 INFO - PROCESS | 3140 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:57:54 INFO - PROCESS | 3140 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:57:54 INFO - PROCESS | 3140 | console.error: 11:57:54 INFO - PROCESS | 3140 | Message: Error: Connection closed before committing the transaction. 11:57:54 INFO - PROCESS | 3140 | Stack: 11:57:54 INFO - PROCESS | 3140 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:932:23 11:57:54 INFO - PROCESS | 3140 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 11:57:54 INFO - PROCESS | 3140 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 11:57:54 INFO - PROCESS | 3140 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 11:57:54 INFO - PROCESS | 3140 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 11:57:54 INFO - PROCESS | 3140 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 11:57:54 INFO - PROCESS | 3140 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:550:9 11:57:54 INFO - PROCESS | 3140 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 11:57:54 INFO - PROCESS | 3140 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:386:5 11:57:54 INFO - PROCESS | 3140 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 11:57:54 INFO - PROCESS | 3140 | Barrier/this.client.addBlocker/promise13.4% 11:58:54 INFO - TinderboxPrint: I/O read bytes / time
218,164,736 / 2,179,290 11:58:54 INFO - TinderboxPrint: I/O write bytes / time
416,821,760 / 3,266,130 11:58:54 INFO - TinderboxPrint: CPU idle
8,279.6 (86.6%) 11:58:54 INFO - TinderboxPrint: CPU user
1,233.5 (12.9%) 11:58:54 INFO - install - Wall time: 3s; CPU: 13.0%; Read bytes: 0; Write bytes: 39221248; Read time: 0; Write time: 52760 11:58:54 INFO - run-tests - Wall time: 1193s; CPU: 13.0%; Read bytes: 218164736; Write bytes: 318446080; Read time: 2179290; Write time: 3162150 11:58:55 INFO - Running post-run listener: _upload_blobber_files 11:58:55 INFO - Blob upload gear active. 11:58:55 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 11:58:55 INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:58:55 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Cedar', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 11:58:55 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Cedar -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 11:58:55 INFO - (blobuploader) - INFO - Open directory for files ... 11:58:55 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 11:58:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:58:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:56 INFO - (blobuploader) - INFO - Done attempting. 11:58:56 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 11:58:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:58:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:57 INFO - (blobuploader) - INFO - Done attempting. 11:58:57 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 11:58:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:58:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:59 INFO - (blobuploader) - INFO - Done attempting. 11:58:59 INFO - (blobuploader) - INFO - Iteration through files over. 11:58:59 INFO - Return code: 0 11:58:59 INFO - rmtree: C:\slave\test\build\uploaded_files.json 11:58:59 INFO - Using _rmtree_windows ... 11:58:59 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 11:58:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c0ddad46a1a132cff9598d4c72e2b98db141573e14986f65a8e1a152e1c372051adaac48351de24543fc2a62c305301bd3877e45be9411338d98463cac80439b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3facda9897550aa8330bc11ea69873815d1d337bba9422e4c846c138d846b94157130150e4be15a924424f3c6c59873802dfd160b9f837944d2f89442fa2faed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3a1c022476f24b78334dec91cef768da8cd4cfb8348f7ad34a5e4723ec3351a399ce5cd4b3633f9061bd43386ab407d9c59d10630a2e81c3c15982c04253393"} 11:58:59 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 11:58:59 INFO - Writing to file C:\slave\test\properties\blobber_files 11:58:59 INFO - Contents: 11:58:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c0ddad46a1a132cff9598d4c72e2b98db141573e14986f65a8e1a152e1c372051adaac48351de24543fc2a62c305301bd3877e45be9411338d98463cac80439b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3facda9897550aa8330bc11ea69873815d1d337bba9422e4c846c138d846b94157130150e4be15a924424f3c6c59873802dfd160b9f837944d2f89442fa2faed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3a1c022476f24b78334dec91cef768da8cd4cfb8348f7ad34a5e4723ec3351a399ce5cd4b3633f9061bd43386ab407d9c59d10630a2e81c3c15982c04253393"} 11:58:59 INFO - Running post-run listener: copy_logs_to_upload_dir 11:58:59 INFO - Copying logs to upload dir... 11:58:59 INFO - mkdir: C:\slave\test\build\upload\logs 11:58:59 INFO - Copying logs to upload dir... 11:58:59 INFO - Using _rmtree_windows ... 11:58:59 INFO - Using _rmtree_windows ... 11:58:59 INFO - Using _rmtree_windows ... 11:58:59 INFO - Using _rmtree_windows ... 11:58:59 INFO - Using _rmtree_windows ... 11:58:59 INFO - Using _rmtree_windows ... 11:58:59 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1408.483000 ========= master_lag: -0.04 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 28 secs) (at 2016-11-18 11:58:59.778585) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 11:58:59.779412) ========= '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-100\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-100 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-100 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-100\AppData\Local LOGONSERVER=\\T-W864-IX-100 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-100 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-100 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-100 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c0ddad46a1a132cff9598d4c72e2b98db141573e14986f65a8e1a152e1c372051adaac48351de24543fc2a62c305301bd3877e45be9411338d98463cac80439b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3facda9897550aa8330bc11ea69873815d1d337bba9422e4c846c138d846b94157130150e4be15a924424f3c6c59873802dfd160b9f837944d2f89442fa2faed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3a1c022476f24b78334dec91cef768da8cd4cfb8348f7ad34a5e4723ec3351a399ce5cd4b3633f9061bd43386ab407d9c59d10630a2e81c3c15982c04253393"} build_url:https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/I3ObsME3R86nuRmQ4000WA/artifacts/public/build/firefox-53.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c0ddad46a1a132cff9598d4c72e2b98db141573e14986f65a8e1a152e1c372051adaac48351de24543fc2a62c305301bd3877e45be9411338d98463cac80439b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3facda9897550aa8330bc11ea69873815d1d337bba9422e4c846c138d846b94157130150e4be15a924424f3c6c59873802dfd160b9f837944d2f89442fa2faed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3a1c022476f24b78334dec91cef768da8cd4cfb8348f7ad34a5e4723ec3351a399ce5cd4b3633f9061bd43386ab407d9c59d10630a2e81c3c15982c04253393"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 11:58:59.901989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 11:58:59.902345) ========= '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-100\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-100 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-100 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-100\AppData\Local LOGONSERVER=\\T-W864-IX-100 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-100 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-100 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-100 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.102000 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 11:59:00.150704) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-11-18 11:59:00.151019) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-11-18 11:59:00.645243) ========= ========= Total master_lag: 0.24 =========