builder: graphics_win8_64_test-dromaeojs slave: t-w864-ix-272 starttime: 1480650758.79 results: success (0) buildid: 20161201184344 builduid: ef297ffe42384c49abda34f6edfd7899 revision: 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 19:52:38.785754) ========= master: http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 19:52:38.786233) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 19:52:38.786517) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 19:52:38.871439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-01 19:52:38.871887) ========= '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-272\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-272 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-272 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-272\AppData\Local LOGONSERVER=\\T-W864-IX-272 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-272 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-272 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-272 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --19:52:40-- 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% 9.43 MB/s 19:52:40 (9.43 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.428000 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-01 19:52:40.349597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-12-01 19:52:40.349897) ========= '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-272\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-272 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-272 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-272\AppData\Local LOGONSERVER=\\T-W864-IX-272 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-272 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-272 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-272 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.713000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-12-01 19:52:43.087278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-01 19:52:43.087632) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo projects/graphics --rev 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-272\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-272 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-272 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-272\AppData\Local LOGONSERVER=\\T-W864-IX-272 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-272 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-272 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-272 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-12-01 19:52:43,835 truncating revision to first 12 chars 2016-12-01 19:52:43,835 Setting DEBUG logging. 2016-12-01 19:52:43,835 attempt 1/10 2016-12-01 19:52:43,835 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/02fdf5d71d8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 19:52:44,263 unpacking tar archive at: graphics-02fdf5d71d8e/testing/mozharness/ 2016-12-01 19:52:44,365 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.096000 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-01 19:52:44.245290) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 19:52:44.245708) ========= script_repo_revision: 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 19:52:44.246212) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 19:52:44.246503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 19:52:44.268615) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 57 secs) (at 2016-12-01 19:52:44.269024) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Graphics' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Graphics' 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', 'Graphics', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-272\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-272 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-272 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-272\AppData\Local LOGONSERVER=\\T-W864-IX-272 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-272 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-272 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-272 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 19:52:45 INFO - MultiFileLogger online at 20161201 19:52:45 in C:\slave\test 19:52:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 19:52:45 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 19:52:45 INFO - {'append_to_log': False, 19:52:45 INFO - 'base_work_dir': 'C:\\slave\\test', 19:52:45 INFO - 'blob_upload_branch': 'Graphics', 19:52:45 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 19:52:45 INFO - 'branch': 'Graphics', 19:52:45 INFO - 'buildbot_json_path': 'buildprops.json', 19:52:45 INFO - 'config_files': ('talos/windows_config.py',), 19:52:45 INFO - 'default_actions': ('clobber', 19:52:45 INFO - 'read-buildbot-config', 19:52:45 INFO - 'download-and-extract', 19:52:45 INFO - 'populate-webroot', 19:52:45 INFO - 'create-virtualenv', 19:52:45 INFO - 'install', 19:52:45 INFO - 'run-tests'), 19:52:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:52:45 INFO - 'download_minidump_stackwalk': True, 19:52:45 INFO - 'download_symbols': 'ondemand', 19:52:45 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 19:52:45 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 19:52:45 INFO - 'hg': 'c:/mozilla-build/hg/hg', 19:52:45 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 19:52:45 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 19:52:45 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 19:52:45 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 19:52:45 INFO - 'C:/mozilla-build/tooltool.py'), 19:52:45 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 19:52:45 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 19:52:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:52:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:52:45 INFO - 'installer_path': 'installer.exe', 19:52:45 INFO - 'log_level': 'info', 19:52:45 INFO - 'log_name': 'talos', 19:52:45 INFO - 'log_to_console': True, 19:52:45 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 19:52:45 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 19:52:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 19:52:45 INFO - 'opt_config_files': (), 19:52:45 INFO - 'pip_index': False, 19:52:45 INFO - 'sps_profile': False, 19:52:45 INFO - 'sps_profile_interval': 0, 19:52:45 INFO - 'suite': 'dromaeojs', 19:52:45 INFO - 'system_bits': '32', 19:52:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:52:45 INFO - 'title': 'T-W864-IX-272', 19:52:45 INFO - 'use_talos_json': True, 19:52:45 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 19:52:45 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 19:52:45 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 19:52:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:52:45 INFO - 'work_dir': 'build'} 19:52:45 INFO - [mozharness: 2016-12-02 03:52:45.157000Z] Running clobber step. 19:52:45 INFO - Running pre-action listener: _resource_record_pre_action 19:52:45 INFO - Running main action method: clobber 19:52:45 INFO - rmtree: C:\slave\test\build 19:52:45 INFO - Using _rmtree_windows ... 19:52:45 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 19:54:15 INFO - Running post-action listener: _resource_record_post_action 19:54:15 INFO - [mozharness: 2016-12-02 03:54:15.415000Z] Finished clobber step (success) 19:54:15 INFO - [mozharness: 2016-12-02 03:54:15.415000Z] Running read-buildbot-config step. 19:54:15 INFO - Running pre-action listener: _resource_record_pre_action 19:54:15 INFO - Running main action method: read_buildbot_config 19:54:15 INFO - Using buildbot properties: 19:54:15 INFO - { 19:54:15 INFO - "project": "", 19:54:15 INFO - "product": "firefox", 19:54:15 INFO - "script_repo_revision": "default", 19:54:15 INFO - "builddir": "graphics_win8_64_test-dromaeojs", 19:54:15 INFO - "repository": "", 19:54:15 INFO - "buildername": "Windows 8 64-bit graphics talos dromaeojs", 19:54:15 INFO - "buildid": "20161201184344", 19:54:15 INFO - "pgo_build": "False", 19:54:15 INFO - "basedir": "C:\\slave\\test", 19:54:15 INFO - "buildnumber": 3, 19:54:15 INFO - "slavename": "t-w864-ix-272", 19:54:15 INFO - "master": "http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/", 19:54:15 INFO - "platform": "win8_64", 19:54:15 INFO - "scheduler": "tests-graphics-win64-talos", 19:54:15 INFO - "branch": "graphics", 19:54:15 INFO - "repo_path": "projects/graphics", 19:54:15 INFO - "revision": "02fdf5d71d8e22357c82e0ab828544f4cd2f1250", 19:54:15 INFO - "stage_platform": "win64", 19:54:15 INFO - "builduid": "ef297ffe42384c49abda34f6edfd7899", 19:54:15 INFO - "slavebuilddir": "test" 19:54:15 INFO - } 19:54:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.zip. 19:54:15 INFO - Running post-action listener: _resource_record_post_action 19:54:15 INFO - [mozharness: 2016-12-02 03:54:15.418000Z] Finished read-buildbot-config step (success) 19:54:15 INFO - [mozharness: 2016-12-02 03:54:15.418000Z] Running download-and-extract step. 19:54:15 INFO - Running pre-action listener: _resource_record_pre_action 19:54:15 INFO - Running main action method: download_and_extract 19:54:15 INFO - mkdir: C:\slave\test\build\tests 19:54:15 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')]} 19:54:15 INFO - trying https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.test_packages.json 19:54:15 INFO - Downloading https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/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 19:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/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 19:54:16 INFO - Downloaded 1274 bytes. 19:54:16 INFO - Reading from file C:\slave\test\build\firefox-53.0a1.en-US.win64.test_packages.json 19:54:16 INFO - Using the following test package requirements: 19:54:16 INFO - {u'common': [u'firefox-53.0a1.en-US.win64.common.tests.zip'], 19:54:16 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 19:54:16 INFO - u'firefox-53.0a1.en-US.win64.cppunittest.tests.zip'], 19:54:16 INFO - u'gtest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 19:54:16 INFO - u'firefox-53.0a1.en-US.win64.gtest.tests.zip'], 19:54:16 INFO - u'jittest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 19:54:16 INFO - u'jsshell-win64.zip'], 19:54:16 INFO - u'mochitest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 19:54:16 INFO - u'firefox-53.0a1.en-US.win64.mochitest.tests.zip'], 19:54:16 INFO - u'mozbase': [u'firefox-53.0a1.en-US.win64.common.tests.zip'], 19:54:16 INFO - u'reftest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 19:54:16 INFO - u'firefox-53.0a1.en-US.win64.reftest.tests.zip'], 19:54:16 INFO - u'talos': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 19:54:16 INFO - u'firefox-53.0a1.en-US.win64.talos.tests.zip'], 19:54:16 INFO - u'web-platform': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 19:54:16 INFO - u'firefox-53.0a1.en-US.win64.web-platform.tests.zip'], 19:54:16 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 19:54:16 INFO - u'firefox-53.0a1.en-US.win64.xpcshell.tests.zip']} 19:54:16 INFO - Downloading packages: [u'firefox-53.0a1.en-US.win64.common.tests.zip'] for test suite category: common 19:54:16 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip 19:54:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip'}, attempt #1 19:54:16 INFO - Fetch https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip into memory 19:54:16 INFO - Http code: 200 19:54:16 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 19:54:16 INFO - x-amz-cf-id: EhhmvKwNh9Gk3kGJ9WW5Pr5HYLz0Njow_UsK8-c3XDOXK3p-RI3G-w== 19:54:16 INFO - x-amz-version-id: vLqUkbud_UhI9N2Mme0UgEpA1wi3gVe0 19:54:17 INFO - Expected file size: 17160559 19:54:17 INFO - Obtained file size: 17160559 19:54:37 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 19:54:37 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip 19:54:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip'}, attempt #1 19:54:37 INFO - Fetch https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip into memory 19:54:38 INFO - Http code: 200 19:54:38 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 19:54:38 INFO - x-amz-cf-id: mQjTIo6-zRFScHndxlW1LrcQtPkWubeG0DM55Gn9rL1kPBk0xtJDaQ== 19:54:38 INFO - x-amz-version-id: vLqUkbud_UhI9N2Mme0UgEpA1wi3gVe0 19:54:38 INFO - Expected file size: 17160559 19:54:38 INFO - Obtained file size: 17160559 19:54:47 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip 19:54:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip'}, attempt #1 19:54:47 INFO - Fetch https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip into memory 19:54:48 INFO - Http code: 200 19:54:48 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 19:54:48 INFO - x-amz-cf-id: mK6VD4QDlKd33I37BdGQnjcOEb_3ILBO6SRY3JXRN8elxLI9mgsoNw== 19:54:48 INFO - x-amz-version-id: F__KZCJyo4BK_r29WjS2oym6jJktri3Q 19:54:48 INFO - Expected file size: 14409702 19:54:48 INFO - Obtained file size: 14409702 19:54:52 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')]} 19:54:52 INFO - trying https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 19:54:52 INFO - Downloading https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.zip to C:\slave\test\build\firefox-53.0a1.en-US.win64.zip 19:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/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 19:54:53 INFO - Downloaded 57373517 bytes. 19:54:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 19:54:53 INFO - mkdir: C:\slave\test\properties 19:54:53 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 19:54:53 INFO - Writing to file C:\slave\test\properties\build_url 19:54:53 INFO - Contents: 19:54:53 INFO - build_url:https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 19:54:54 INFO - Running post-action listener: _resource_record_post_action 19:54:54 INFO - Running post-action listener: set_extra_try_arguments 19:54:54 INFO - [mozharness: 2016-12-02 03:54:54.480000Z] Finished download-and-extract step (success) 19:54:54 INFO - [mozharness: 2016-12-02 03:54:54.480000Z] Running populate-webroot step. 19:54:54 INFO - Running pre-action listener: _resource_record_pre_action 19:54:54 INFO - Running main action method: populate_webroot 19:54:54 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 19:54:54 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 19:54:54 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 19:54:54 INFO - u'--tppagecycles', 19:54:54 INFO - u'7'], 19:54:54 INFO - u'tests': [u'tsvgm']}}, 19:54:54 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 19:54:54 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 19:54:54 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 19:54:54 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 19:54:54 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 19:54:54 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 19:54:54 INFO - u'g1': {u'pagesets_name': u'tp5n.zip', 19:54:54 INFO - u'talos_options': [u'--disable-e10s'], 19:54:54 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 19:54:54 INFO - u'g1-e10s': {u'pagesets_name': u'tp5n.zip', 19:54:54 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 19:54:54 INFO - u'g2': {u'pagesets_name': u'tp5n.zip', 19:54:54 INFO - u'talos_options': [u'--disable-e10s'], 19:54:54 INFO - u'tests': [u'damp', u'tps']}, 19:54:54 INFO - u'g2-e10s': {u'pagesets_name': u'tp5n.zip', 19:54:54 INFO - u'tests': [u'damp', u'tps']}, 19:54:54 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 19:54:54 INFO - u'tests': [u'dromaeo_dom']}, 19:54:54 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 19:54:54 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 19:54:54 INFO - u'tests': [u'basic_compositor_video']}, 19:54:54 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 19:54:54 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 19:54:54 INFO - u'tests': [u'a11yr', 19:54:54 INFO - u'ts_paint', 19:54:54 INFO - u'tpaint', 19:54:54 INFO - u'sessionrestore', 19:54:54 INFO - u'sessionrestore_no_auto_restore', 19:54:54 INFO - u'tabpaint']}, 19:54:54 INFO - u'other-e10s': {u'tests': [u'a11yr', 19:54:54 INFO - u'ts_paint', 19:54:54 INFO - u'tpaint', 19:54:54 INFO - u'sessionrestore', 19:54:54 INFO - u'sessionrestore_no_auto_restore', 19:54:54 INFO - u'tabpaint']}, 19:54:54 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 19:54:54 INFO - u'ts_paint', 19:54:54 INFO - u'tpaint', 19:54:54 INFO - u'sessionrestore', 19:54:54 INFO - u'sessionrestore_no_auto_restore', 19:54:54 INFO - u'tabpaint']}, 19:54:54 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 19:54:54 INFO - u'ts_paint', 19:54:54 INFO - u'tpaint', 19:54:54 INFO - u'sessionrestore', 19:54:54 INFO - u'sessionrestore_no_auto_restore', 19:54:54 INFO - u'tabpaint']}, 19:54:54 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 19:54:54 INFO - u'tests': [u'a11yr', 19:54:54 INFO - u'ts_paint', 19:54:54 INFO - u'tpaint', 19:54:54 INFO - u'sessionrestore', 19:54:54 INFO - u'sessionrestore_no_auto_restore', 19:54:54 INFO - u'tabpaint']}, 19:54:54 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 19:54:54 INFO - u'tests': [u'a11yr', 19:54:54 INFO - u'ts_paint', 19:54:54 INFO - u'tpaint', 19:54:54 INFO - u'sessionrestore', 19:54:54 INFO - u'sessionrestore_no_auto_restore', 19:54:54 INFO - u'tabpaint']}, 19:54:54 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 19:54:54 INFO - u'tests': [u'tsvgx', 19:54:54 INFO - u'tsvgr_opacity', 19:54:54 INFO - u'tart', 19:54:54 INFO - u'tscrollx', 19:54:54 INFO - u'cart', 19:54:54 INFO - u'tsvg_static']}, 19:54:54 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 19:54:54 INFO - u'tsvgr_opacity', 19:54:54 INFO - u'tart', 19:54:54 INFO - u'tscrollx', 19:54:54 INFO - u'cart', 19:54:54 INFO - u'tsvg_static']}, 19:54:54 INFO - u'tp5o': {u'pagesets_name': u'tp5n.zip', 19:54:54 INFO - u'talos_options': [u'--disable-e10s'], 19:54:54 INFO - u'tests': [u'tp5o']}, 19:54:54 INFO - u'tp5o-e10s': {u'pagesets_name': u'tp5n.zip', 19:54:54 INFO - u'tests': [u'tp5o']}, 19:54:54 INFO - u'xperf': {u'pagesets_name': u'tp5n.zip', 19:54:54 INFO - u'talos_options': [u'--disable-e10s', 19:54:54 INFO - u'--xperf_path', 19:54:54 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:54:54 INFO - u'tests': [u'tp5n']}, 19:54:54 INFO - u'xperf-e10s': {u'pagesets_name': u'tp5n.zip', 19:54:54 INFO - u'talos_options': [u'--xperf_path', 19:54:54 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:54:54 INFO - u'tests': [u'tp5n']}}, 19:54:54 INFO - u'talos.zip': {u'path': u'', 19:54:54 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:54:54 INFO - Running post-action listener: _resource_record_post_action 19:54:54 INFO - [mozharness: 2016-12-02 03:54:54.525000Z] Finished populate-webroot step (success) 19:54:54 INFO - [mozharness: 2016-12-02 03:54:54.525000Z] Running create-virtualenv step. 19:54:54 INFO - Running pre-action listener: _resource_record_pre_action 19:54:54 INFO - Running main action method: create_virtualenv 19:54:54 INFO - Creating virtualenv C:\slave\test\build/venv 19:54:54 INFO - mkdir: C:\slave\test\build\venv\Scripts 19:54:54 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 19:54:54 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'! 19:54:54 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 19:54:54 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 19:55:01 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 19:55:04 INFO - Installing distribute......................................................................................................................................................................................done. 19:55:05 INFO - Return code: 0 19:55:05 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 19:55:05 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 19:55:06 INFO - Reading from file tmpfile_stdout 19:55:06 INFO - Output received: 19:55:06 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 19:55:06 INFO - Using _rmtree_windows ... 19:55:06 INFO - Using _rmtree_windows ... 19:55:06 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 19:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:06 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028A7020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E8FCC8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C5E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028865C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-272', 'USERDOMAIN': 'T-W864-IX-272', '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-272', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-272', '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-272\\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 19:55:06 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build 19:55:06 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:55:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:55:06 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Roaming', 19:55:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:55:06 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:55:06 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:55:06 INFO - 'COMPUTERNAME': 'T-W864-IX-272', 19:55:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:55:06 INFO - 'DCLOCATION': 'SCL3', 19:55:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:55:06 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:55:06 INFO - 'HOMEDRIVE': 'C:', 19:55:06 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 19:55:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:55:06 INFO - 'KTS_VERSION': '1.19c', 19:55:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 19:55:06 INFO - 'LOGONSERVER': '\\\\T-W864-IX-272', 19:55:06 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:55:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:06 INFO - 'MOZ_NO_REMOTE': '1', 19:55:06 INFO - 'NO_EM_RESTART': '1', 19:55:06 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:55:06 INFO - 'OS': 'Windows_NT', 19:55:06 INFO - 'OURDRIVE': 'C:', 19:55:06 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 19:55:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:55:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:55:06 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:55:06 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:55:06 INFO - 'PROCESSOR_LEVEL': '6', 19:55:06 INFO - 'PROCESSOR_REVISION': '1e05', 19:55:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:55:06 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:55:06 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:55:06 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:55:06 INFO - 'PROMPT': '$P$G', 19:55:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:55:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:55:06 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:55:06 INFO - 'PWD': 'C:\\slave\\test', 19:55:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:55:06 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:55:06 INFO - 'SYSTEMDRIVE': 'C:', 19:55:06 INFO - 'SYSTEMROOT': 'C:\\windows', 19:55:06 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:06 INFO - 'TEST1': 'testie', 19:55:06 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:06 INFO - 'USERDOMAIN': 'T-W864-IX-272', 19:55:06 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 19:55:06 INFO - 'USERNAME': 'cltbld', 19:55:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-272', 19:55:06 INFO - 'WINDIR': 'C:\\windows', 19:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:55:06 INFO - Ignoring indexes: http://pypi.python.org/simple/ 19:55:06 INFO - Downloading/unpacking pip>=1.5 19:55:10 INFO - Running setup.py egg_info for package pip 19:55:10 INFO - warning: no files found matching 'pip\cacert.pem' 19:55:10 INFO - warning: no files found matching '*.html' under directory 'docs' 19:55:10 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 19:55:10 INFO - no previously-included directories found matching 'docs\_build\_sources' 19:55:10 INFO - Installing collected packages: pip 19:55:10 INFO - Found existing installation: pip 0.8.2 19:55:10 INFO - Uninstalling pip: 19:55:10 INFO - Successfully uninstalled pip 19:55:10 INFO - Running setup.py install for pip 19:55:10 INFO - warning: no files found matching 'pip\cacert.pem' 19:55:10 INFO - warning: no files found matching '*.html' under directory 'docs' 19:55:10 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 19:55:10 INFO - no previously-included directories found matching 'docs\_build\_sources' 19:55:10 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 19:55:10 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 19:55:10 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 19:55:10 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 19:55:10 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 19:55:10 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 19:55:10 INFO - Successfully installed pip 19:55:10 INFO - Cleaning up... 19:55:11 INFO - Return code: 0 19:55:11 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 19:55:11 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')]} 19:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:11 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')]} 19:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:11 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 0x022FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028A7020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E8FCC8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C5E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028865C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-272', 'USERDOMAIN': 'T-W864-IX-272', '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-272', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-272', '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-272\\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 19:55:11 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 19:55:11 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 19:55:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:55:11 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Roaming', 19:55:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:55:11 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:55:11 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:55:11 INFO - 'COMPUTERNAME': 'T-W864-IX-272', 19:55:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:55:11 INFO - 'DCLOCATION': 'SCL3', 19:55:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:55:11 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:55:11 INFO - 'HOMEDRIVE': 'C:', 19:55:11 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 19:55:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:55:11 INFO - 'KTS_VERSION': '1.19c', 19:55:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 19:55:11 INFO - 'LOGONSERVER': '\\\\T-W864-IX-272', 19:55:11 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:55:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:11 INFO - 'MOZ_NO_REMOTE': '1', 19:55:11 INFO - 'NO_EM_RESTART': '1', 19:55:11 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:55:11 INFO - 'OS': 'Windows_NT', 19:55:11 INFO - 'OURDRIVE': 'C:', 19:55:11 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 19:55:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:55:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:55:11 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:55:11 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:55:11 INFO - 'PROCESSOR_LEVEL': '6', 19:55:11 INFO - 'PROCESSOR_REVISION': '1e05', 19:55:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:55:11 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:55:11 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:55:11 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:55:11 INFO - 'PROMPT': '$P$G', 19:55:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:55:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:55:11 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:55:11 INFO - 'PWD': 'C:\\slave\\test', 19:55:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:55:11 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:55:11 INFO - 'SYSTEMDRIVE': 'C:', 19:55:11 INFO - 'SYSTEMROOT': 'C:\\windows', 19:55:11 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:11 INFO - 'TEST1': 'testie', 19:55:11 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:11 INFO - 'USERDOMAIN': 'T-W864-IX-272', 19:55:11 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 19:55:11 INFO - 'USERNAME': 'cltbld', 19:55:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-272', 19:55:11 INFO - 'WINDIR': 'C:\\windows', 19:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:12 INFO - Downloading/unpacking psutil>=3.1.1 19:55:12 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 19:55:12 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 19:55:13 INFO - Installing collected packages: psutil 19:55:13 INFO - Successfully installed psutil 19:55:13 INFO - Cleaning up... 19:55:13 INFO - Return code: 0 19:55:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 19:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:13 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 0x022FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028A7020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E8FCC8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C5E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028865C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-272', 'USERDOMAIN': 'T-W864-IX-272', '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-272', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-272', '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-272\\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 19:55:13 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 19:55:13 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 19:55:13 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:55:13 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Roaming', 19:55:13 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:55:13 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:55:13 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:55:13 INFO - 'COMPUTERNAME': 'T-W864-IX-272', 19:55:13 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:55:13 INFO - 'DCLOCATION': 'SCL3', 19:55:13 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:55:13 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:55:13 INFO - 'HOMEDRIVE': 'C:', 19:55:13 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 19:55:13 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:55:13 INFO - 'KTS_VERSION': '1.19c', 19:55:13 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 19:55:13 INFO - 'LOGONSERVER': '\\\\T-W864-IX-272', 19:55:13 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:55:13 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:13 INFO - 'MOZ_NO_REMOTE': '1', 19:55:13 INFO - 'NO_EM_RESTART': '1', 19:55:13 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:55:13 INFO - 'OS': 'Windows_NT', 19:55:13 INFO - 'OURDRIVE': 'C:', 19:55:13 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', 19:55:13 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:55:13 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:55:13 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:55:13 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:55:13 INFO - 'PROCESSOR_LEVEL': '6', 19:55:13 INFO - 'PROCESSOR_REVISION': '1e05', 19:55:13 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:55:13 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:55:13 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:55:13 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:55:13 INFO - 'PROMPT': '$P$G', 19:55:13 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:55:13 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:55:13 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:55:13 INFO - 'PWD': 'C:\\slave\\test', 19:55:13 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:55:13 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:55:13 INFO - 'SYSTEMDRIVE': 'C:', 19:55:13 INFO - 'SYSTEMROOT': 'C:\\windows', 19:55:13 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:13 INFO - 'TEST1': 'testie', 19:55:13 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:13 INFO - 'USERDOMAIN': 'T-W864-IX-272', 19:55:13 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 19:55:13 INFO - 'USERNAME': 'cltbld', 19:55:13 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-272', 19:55:13 INFO - 'WINDIR': 'C:\\windows', 19:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:55:14 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 19:55:14 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 19:55:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:55:15 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 19:55:15 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) 19:55:15 INFO - Installing collected packages: mozsystemmonitor 19:55:15 INFO - Running setup.py install for mozsystemmonitor 19:55:15 INFO - Successfully installed mozsystemmonitor 19:55:15 INFO - Cleaning up... 19:55:15 INFO - Return code: 0 19:55:15 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 19:55:15 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')]} 19:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:15 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')]} 19:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:15 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 0x022FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028A7020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E8FCC8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C5E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028865C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-272', 'USERDOMAIN': 'T-W864-IX-272', '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-272', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-272', '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-272\\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 19:55:15 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 19:55:15 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 19:55:15 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:55:15 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Roaming', 19:55:15 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:55:15 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:55:15 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:55:15 INFO - 'COMPUTERNAME': 'T-W864-IX-272', 19:55:15 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:55:15 INFO - 'DCLOCATION': 'SCL3', 19:55:15 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:55:15 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:55:15 INFO - 'HOMEDRIVE': 'C:', 19:55:15 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 19:55:15 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:55:15 INFO - 'KTS_VERSION': '1.19c', 19:55:15 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 19:55:15 INFO - 'LOGONSERVER': '\\\\T-W864-IX-272', 19:55:15 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:55:15 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:15 INFO - 'MOZ_NO_REMOTE': '1', 19:55:15 INFO - 'NO_EM_RESTART': '1', 19:55:15 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:55:15 INFO - 'OS': 'Windows_NT', 19:55:15 INFO - 'OURDRIVE': 'C:', 19:55:15 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', 19:55:15 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:55:15 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:55:15 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:55:15 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:55:15 INFO - 'PROCESSOR_LEVEL': '6', 19:55:15 INFO - 'PROCESSOR_REVISION': '1e05', 19:55:15 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:55:15 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:55:15 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:55:15 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:55:15 INFO - 'PROMPT': '$P$G', 19:55:15 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:55:15 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:55:15 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:55:15 INFO - 'PWD': 'C:\\slave\\test', 19:55:15 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:55:15 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:55:15 INFO - 'SYSTEMDRIVE': 'C:', 19:55:15 INFO - 'SYSTEMROOT': 'C:\\windows', 19:55:15 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:15 INFO - 'TEST1': 'testie', 19:55:15 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:15 INFO - 'USERDOMAIN': 'T-W864-IX-272', 19:55:15 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 19:55:15 INFO - 'USERNAME': 'cltbld', 19:55:15 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-272', 19:55:15 INFO - 'WINDIR': 'C:\\windows', 19:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:16 INFO - Downloading/unpacking jsonschema==2.5.1 19:55:16 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 19:55:16 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 19:55:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:55:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:55:17 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 19:55:17 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 19:55:17 INFO - Downloading functools32-3.2.3-2.tar.gz 19:55:17 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 19:55:17 INFO - warning: no files found matching '*.txt' 19:55:17 INFO - no previously-included directories found matching 'build' 19:55:17 INFO - no previously-included directories found matching 'dist' 19:55:17 INFO - no previously-included directories found matching '.git*' 19:55:17 INFO - Installing collected packages: jsonschema, functools32 19:55:17 INFO - Running setup.py install for functools32 19:55:17 INFO - warning: no files found matching '*.txt' 19:55:17 INFO - no previously-included directories found matching 'build' 19:55:17 INFO - no previously-included directories found matching 'dist' 19:55:17 INFO - no previously-included directories found matching '.git*' 19:55:17 INFO - Successfully installed jsonschema functools32 19:55:17 INFO - Cleaning up... 19:55:18 INFO - Return code: 0 19:55:18 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 19:55:18 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')]} 19:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:18 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')]} 19:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:18 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 0x022FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028A7020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E8FCC8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C5E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028865C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-272', 'USERDOMAIN': 'T-W864-IX-272', '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-272', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-272', '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-272\\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 19:55:18 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 19:55:18 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 19:55:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:55:18 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Roaming', 19:55:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:55:18 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:55:18 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:55:18 INFO - 'COMPUTERNAME': 'T-W864-IX-272', 19:55:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:55:18 INFO - 'DCLOCATION': 'SCL3', 19:55:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:55:18 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:55:18 INFO - 'HOMEDRIVE': 'C:', 19:55:18 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 19:55:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:55:18 INFO - 'KTS_VERSION': '1.19c', 19:55:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 19:55:18 INFO - 'LOGONSERVER': '\\\\T-W864-IX-272', 19:55:18 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:55:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:18 INFO - 'MOZ_NO_REMOTE': '1', 19:55:18 INFO - 'NO_EM_RESTART': '1', 19:55:18 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:55:18 INFO - 'OS': 'Windows_NT', 19:55:18 INFO - 'OURDRIVE': 'C:', 19:55:18 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', 19:55:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:55:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:55:18 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:55:18 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:55:18 INFO - 'PROCESSOR_LEVEL': '6', 19:55:18 INFO - 'PROCESSOR_REVISION': '1e05', 19:55:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:55:18 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:55:18 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:55:18 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:55:18 INFO - 'PROMPT': '$P$G', 19:55:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:55:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:55:18 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:55:18 INFO - 'PWD': 'C:\\slave\\test', 19:55:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:55:18 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:55:18 INFO - 'SYSTEMDRIVE': 'C:', 19:55:18 INFO - 'SYSTEMROOT': 'C:\\windows', 19:55:18 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:18 INFO - 'TEST1': 'testie', 19:55:18 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:18 INFO - 'USERDOMAIN': 'T-W864-IX-272', 19:55:18 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 19:55:18 INFO - 'USERNAME': 'cltbld', 19:55:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-272', 19:55:18 INFO - 'WINDIR': 'C:\\windows', 19:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 19:55:18 INFO - Cleaning up... 19:55:18 INFO - Return code: 0 19:55:18 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 19:55:18 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')]} 19:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:18 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')]} 19:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:18 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 0x022FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028A7020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E8FCC8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C5E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028865C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-272', 'USERDOMAIN': 'T-W864-IX-272', '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-272', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-272', '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-272\\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 19:55:18 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 19:55:18 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 19:55:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:55:18 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Roaming', 19:55:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:55:18 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:55:18 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:55:18 INFO - 'COMPUTERNAME': 'T-W864-IX-272', 19:55:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:55:18 INFO - 'DCLOCATION': 'SCL3', 19:55:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:55:18 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:55:18 INFO - 'HOMEDRIVE': 'C:', 19:55:18 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 19:55:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:55:18 INFO - 'KTS_VERSION': '1.19c', 19:55:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 19:55:18 INFO - 'LOGONSERVER': '\\\\T-W864-IX-272', 19:55:18 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:55:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:18 INFO - 'MOZ_NO_REMOTE': '1', 19:55:18 INFO - 'NO_EM_RESTART': '1', 19:55:18 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:55:18 INFO - 'OS': 'Windows_NT', 19:55:18 INFO - 'OURDRIVE': 'C:', 19:55:18 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', 19:55:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:55:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:55:18 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:55:18 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:55:18 INFO - 'PROCESSOR_LEVEL': '6', 19:55:18 INFO - 'PROCESSOR_REVISION': '1e05', 19:55:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:55:18 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:55:18 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:55:18 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:55:18 INFO - 'PROMPT': '$P$G', 19:55:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:55:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:55:18 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:55:18 INFO - 'PWD': 'C:\\slave\\test', 19:55:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:55:18 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:55:18 INFO - 'SYSTEMDRIVE': 'C:', 19:55:18 INFO - 'SYSTEMROOT': 'C:\\windows', 19:55:18 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:18 INFO - 'TEST1': 'testie', 19:55:18 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:18 INFO - 'USERDOMAIN': 'T-W864-IX-272', 19:55:18 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 19:55:18 INFO - 'USERNAME': 'cltbld', 19:55:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-272', 19:55:18 INFO - 'WINDIR': 'C:\\windows', 19:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:18 INFO - Downloading/unpacking blobuploader==1.2.4 19:55:18 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 19:55:18 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 19:55:19 INFO - Downloading blobuploader-1.2.4.tar.gz 19:55:19 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 19:55:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:55:19 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 19:55:19 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 19:55:20 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 19:55:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:55:20 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 19:55:20 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 19:55:20 INFO - Downloading docopt-0.6.1.tar.gz 19:55:20 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 19:55:20 INFO - Installing collected packages: blobuploader, requests, docopt 19:55:20 INFO - Running setup.py install for blobuploader 19:55:20 INFO - Running setup.py install for requests 19:55:21 INFO - Running setup.py install for docopt 19:55:21 INFO - Successfully installed blobuploader requests docopt 19:55:21 INFO - Cleaning up... 19:55:22 INFO - Return code: 0 19:55:22 INFO - Installing None into virtualenv C:\slave\test\build/venv 19:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:22 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 0x022FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028A7020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E8FCC8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C5E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028865C0>, '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-272', 'USERDOMAIN': 'T-W864-IX-272', '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-272', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-272', '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-272\\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 19:55:22 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 19:55:22 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 19:55:22 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:55:22 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Roaming', 19:55:22 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:55:22 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:55:22 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:55:22 INFO - 'COMPUTERNAME': 'T-W864-IX-272', 19:55:22 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:55:22 INFO - 'DCLOCATION': 'SCL3', 19:55:22 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:55:22 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:55:22 INFO - 'HOMEDRIVE': 'C:', 19:55:22 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 19:55:22 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:55:22 INFO - 'KTS_VERSION': '1.19c', 19:55:22 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 19:55:22 INFO - 'LOGONSERVER': '\\\\T-W864-IX-272', 19:55:22 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:55:22 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:22 INFO - 'MOZ_NO_REMOTE': '1', 19:55:22 INFO - 'NO_EM_RESTART': '1', 19:55:22 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:55:22 INFO - 'OS': 'Windows_NT', 19:55:22 INFO - 'OURDRIVE': 'C:', 19:55:22 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', 19:55:22 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:55:22 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:55:22 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:55:22 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:55:22 INFO - 'PROCESSOR_LEVEL': '6', 19:55:22 INFO - 'PROCESSOR_REVISION': '1e05', 19:55:22 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:55:22 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:55:22 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:55:22 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:55:22 INFO - 'PROMPT': '$P$G', 19:55:22 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:55:22 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:55:22 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:55:22 INFO - 'PWD': 'C:\\slave\\test', 19:55:22 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:55:22 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:55:22 INFO - 'SYSTEMDRIVE': 'C:', 19:55:22 INFO - 'SYSTEMROOT': 'C:\\windows', 19:55:22 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:22 INFO - 'TEST1': 'testie', 19:55:22 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:22 INFO - 'USERDOMAIN': 'T-W864-IX-272', 19:55:22 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 19:55:22 INFO - 'USERNAME': 'cltbld', 19:55:22 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-272', 19:55:22 INFO - 'WINDIR': 'C:\\windows', 19:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 19:55:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qynkmk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 19:55:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 19:55:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ucbd7p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 19:55:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 19:55:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-u20dim-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 19:55:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 19:55:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ng3qns-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 19:55:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 19:55:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-f8wp5p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 19:55:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 19:55:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1dtimq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 19:55:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 19:55:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4pqoxw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 19:55:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 19:55:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4vugwo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 19:55:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 19:55:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2j8hmk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 19:55:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 19:55:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kq5kqv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 19:55:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 19:55:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-g6snzg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 19:55:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 19:55:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tmmial-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 19:55:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 19:55:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bdtzby-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 19:55:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 19:55:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-10rqmi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 19:55:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 19:55:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sssp4n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 19:55:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 19:55:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ndwmze-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 19:55:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 19:55:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wn8wto-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 19:55:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:55:25 INFO - Running setup.py install for manifestparser 19:55:25 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 19:55:25 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 19:55:25 INFO - Running setup.py install for mozcrash 19:55:25 INFO - Running setup.py install for mozdebug 19:55:26 INFO - Running setup.py install for mozdevice 19:55:26 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 19:55:26 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 19:55:26 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 19:55:26 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 19:55:27 INFO - Running setup.py install for mozfile 19:55:27 INFO - Running setup.py install for mozhttpd 19:55:27 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 19:55:27 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 19:55:28 INFO - Running setup.py install for mozinfo 19:55:28 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 19:55:28 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 19:55:28 INFO - Running setup.py install for mozInstall 19:55:28 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 19:55:28 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 19:55:28 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 19:55:28 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 19:55:28 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 19:55:28 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 19:55:28 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 19:55:28 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 19:55:28 INFO - Running setup.py install for mozleak 19:55:29 INFO - Running setup.py install for mozlog 19:55:29 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 19:55:29 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 19:55:30 INFO - Running setup.py install for moznetwork 19:55:30 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 19:55:30 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 19:55:30 INFO - Running setup.py install for mozprocess 19:55:30 INFO - Running setup.py install for mozprofile 19:55:31 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 19:55:31 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 19:55:31 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 19:55:31 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 19:55:31 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 19:55:31 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 19:55:31 INFO - Running setup.py install for mozrunner 19:55:31 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 19:55:31 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 19:55:32 INFO - Running setup.py install for mozscreenshot 19:55:32 INFO - Running setup.py install for moztest 19:55:32 INFO - Running setup.py install for mozversion 19:55:33 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 19:55:33 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 19:55:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:55:33 INFO - Cleaning up... 19:55:33 INFO - Return code: 0 19:55:33 INFO - Installing None into virtualenv C:\slave\test\build/venv 19:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:33 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 0x022FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028A7020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E8FCC8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C5E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028865C0>, '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-272', 'USERDOMAIN': 'T-W864-IX-272', '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-272', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-272', '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-272\\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 19:55:33 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 19:55:33 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 19:55:33 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:55:33 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Roaming', 19:55:33 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:55:33 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:55:33 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:55:33 INFO - 'COMPUTERNAME': 'T-W864-IX-272', 19:55:33 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:55:33 INFO - 'DCLOCATION': 'SCL3', 19:55:33 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:55:33 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:55:33 INFO - 'HOMEDRIVE': 'C:', 19:55:33 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 19:55:33 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:55:33 INFO - 'KTS_VERSION': '1.19c', 19:55:33 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 19:55:33 INFO - 'LOGONSERVER': '\\\\T-W864-IX-272', 19:55:33 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:55:33 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:33 INFO - 'MOZ_NO_REMOTE': '1', 19:55:33 INFO - 'NO_EM_RESTART': '1', 19:55:33 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:55:33 INFO - 'OS': 'Windows_NT', 19:55:33 INFO - 'OURDRIVE': 'C:', 19:55:33 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 19:55:33 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:55:33 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:55:33 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:55:33 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:55:33 INFO - 'PROCESSOR_LEVEL': '6', 19:55:33 INFO - 'PROCESSOR_REVISION': '1e05', 19:55:33 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:55:33 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:55:33 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:55:33 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:55:33 INFO - 'PROMPT': '$P$G', 19:55:33 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:55:33 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:55:33 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:55:33 INFO - 'PWD': 'C:\\slave\\test', 19:55:33 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:55:33 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:55:33 INFO - 'SYSTEMDRIVE': 'C:', 19:55:33 INFO - 'SYSTEMROOT': 'C:\\windows', 19:55:33 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:33 INFO - 'TEST1': 'testie', 19:55:33 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:33 INFO - 'USERDOMAIN': 'T-W864-IX-272', 19:55:33 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 19:55:33 INFO - 'USERNAME': 'cltbld', 19:55:33 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-272', 19:55:33 INFO - 'WINDIR': 'C:\\windows', 19:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:33 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 19:55:33 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bhcx67-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 19:55:33 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)) 19:55:33 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 19:55:33 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-q3hj0z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 19:55:33 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)) 19:55:33 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 19:55:33 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5nyufq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 19:55:33 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)) 19:55:33 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 19:55:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rm1fyy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 19:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 19:55:34 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 19:55:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vqc0de-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 19:55:34 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)) 19:55:34 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 19:55:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nhkrzz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 19:55:34 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)) 19:55:34 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 19:55:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zoq3qi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 19:55:34 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)) 19:55:34 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 19:55:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yzyyuj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 19:55:34 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)) 19:55:34 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 19:55:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-stcwxz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 19:55:34 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)) 19:55:34 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 19:55:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qjxnw1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 19:55:34 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)) 19:55:34 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 19:55:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0gi9xh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 19:55:34 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)) 19:55:34 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 19:55:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ew83ib-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 19:55:35 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)) 19:55:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 19:55:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gjdwrd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 19:55:35 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)) 19:55:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 19:55:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-15l2zw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 19:55:35 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)) 19:55:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 19:55:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ajyhhw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 19:55:35 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)) 19:55:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 19:55:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gerr5b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 19:55:35 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)) 19:55:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 19:55:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-oaghrk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 19:55:35 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)) 19:55:35 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)) 19:55:35 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)) 19:55:35 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)) 19:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.49->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 19:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.49->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 19:55:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 19:55: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 19:55: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 19:55:36 INFO - Downloading blessings-1.6.tar.gz 19:55:36 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 19:55:37 INFO - Installing collected packages: blessings 19:55:37 INFO - Running setup.py install for blessings 19:55:37 INFO - Successfully installed blessings 19:55:37 INFO - Cleaning up... 19:55:40 INFO - Return code: 0 19:55:40 INFO - Done creating virtualenv C:\slave\test\build/venv. 19:55:40 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 19:55:40 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 19:55:40 INFO - Reading from file tmpfile_stdout 19:55:40 INFO - Using _rmtree_windows ... 19:55:40 INFO - Using _rmtree_windows ... 19:55:40 INFO - Current package versions: 19:55:40 INFO - blessings == 1.6 19:55:40 INFO - blobuploader == 1.2.4 19:55:40 INFO - docopt == 0.6.1 19:55:40 INFO - functools32 == 3.2.3-2 19:55:40 INFO - jsonschema == 2.5.1 19:55:40 INFO - manifestparser == 1.1 19:55:40 INFO - mozInstall == 1.12 19:55:40 INFO - mozcrash == 1.0 19:55:40 INFO - mozdebug == 0.1 19:55:40 INFO - mozdevice == 0.49 19:55:40 INFO - mozfile == 1.2 19:55:40 INFO - mozhttpd == 0.7 19:55:40 INFO - mozinfo == 0.9 19:55:40 INFO - mozleak == 0.1 19:55:40 INFO - mozlog == 3.4 19:55:40 INFO - moznetwork == 0.27 19:55:40 INFO - mozprocess == 0.23 19:55:40 INFO - mozprofile == 0.28 19:55:40 INFO - mozrunner == 6.13 19:55:40 INFO - mozscreenshot == 0.1 19:55:40 INFO - mozsystemmonitor == 0.3 19:55:40 INFO - moztest == 0.7 19:55:40 INFO - mozversion == 1.4 19:55:40 INFO - psutil == 3.1.1 19:55:40 INFO - requests == 1.2.3 19:55:40 INFO - Installing None into virtualenv C:\slave\test\build/venv 19:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:40 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 0x022FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028A7020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E8FCC8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C5E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028865C0>, '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-272', 'USERDOMAIN': 'T-W864-IX-272', '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-272', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-272', '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-272\\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 19:55:40 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 19:55:40 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 19:55:40 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:55:40 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Roaming', 19:55:40 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:55:40 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:55:40 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:55:40 INFO - 'COMPUTERNAME': 'T-W864-IX-272', 19:55:40 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:55:40 INFO - 'DCLOCATION': 'SCL3', 19:55:40 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:55:40 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:55:40 INFO - 'HOMEDRIVE': 'C:', 19:55:40 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 19:55:40 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:55:40 INFO - 'KTS_VERSION': '1.19c', 19:55:40 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 19:55:40 INFO - 'LOGONSERVER': '\\\\T-W864-IX-272', 19:55:40 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:55:40 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:40 INFO - 'MOZ_NO_REMOTE': '1', 19:55:40 INFO - 'NO_EM_RESTART': '1', 19:55:40 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:55:40 INFO - 'OS': 'Windows_NT', 19:55:40 INFO - 'OURDRIVE': 'C:', 19:55:40 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 19:55:40 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:55:40 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:55:40 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:55:40 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:55:40 INFO - 'PROCESSOR_LEVEL': '6', 19:55:40 INFO - 'PROCESSOR_REVISION': '1e05', 19:55:40 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:55:40 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:55:40 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:55:40 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:55:40 INFO - 'PROMPT': '$P$G', 19:55:40 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:55:40 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:55:40 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:55:40 INFO - 'PWD': 'C:\\slave\\test', 19:55:40 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:55:40 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:55:40 INFO - 'SYSTEMDRIVE': 'C:', 19:55:40 INFO - 'SYSTEMROOT': 'C:\\windows', 19:55:40 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:40 INFO - 'TEST1': 'testie', 19:55:40 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:40 INFO - 'USERDOMAIN': 'T-W864-IX-272', 19:55:40 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 19:55:40 INFO - 'USERNAME': 'cltbld', 19:55:40 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-272', 19:55:40 INFO - 'WINDIR': 'C:\\windows', 19:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:40 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)) 19:55:40 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)) 19:55:40 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)) 19:55:40 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)) 19:55:40 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)) 19:55:40 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)) 19:55:40 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)) 19:55:40 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)) 19:55:40 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)) 19:55:40 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)) 19:55:40 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)) 19:55:40 INFO - Cleaning up... 19:55:40 INFO - Return code: 0 19:55:40 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 19:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:40 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028A7020>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01E8FCC8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C5E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028865C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-272', 'USERDOMAIN': 'T-W864-IX-272', '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-272', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-272', '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-272\\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 19:55:40 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 19:55:40 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:55:40 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:55:40 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Roaming', 19:55:40 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:55:40 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:55:40 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:55:40 INFO - 'COMPUTERNAME': 'T-W864-IX-272', 19:55:40 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:55:40 INFO - 'DCLOCATION': 'SCL3', 19:55:40 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:55:40 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:55:40 INFO - 'HOMEDRIVE': 'C:', 19:55:40 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 19:55:40 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:55:40 INFO - 'KTS_VERSION': '1.19c', 19:55:40 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 19:55:40 INFO - 'LOGONSERVER': '\\\\T-W864-IX-272', 19:55:40 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:55:40 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:40 INFO - 'MOZ_NO_REMOTE': '1', 19:55:40 INFO - 'NO_EM_RESTART': '1', 19:55:40 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:55:40 INFO - 'OS': 'Windows_NT', 19:55:40 INFO - 'OURDRIVE': 'C:', 19:55:40 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 19:55:40 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:55:40 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:55:40 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:55:40 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:55:40 INFO - 'PROCESSOR_LEVEL': '6', 19:55:40 INFO - 'PROCESSOR_REVISION': '1e05', 19:55:40 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:55:40 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:55:40 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:55:40 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:55:40 INFO - 'PROMPT': '$P$G', 19:55:40 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:55:40 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:55:40 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:55:40 INFO - 'PWD': 'C:\\slave\\test', 19:55:40 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:55:40 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:55:40 INFO - 'SYSTEMDRIVE': 'C:', 19:55:40 INFO - 'SYSTEMROOT': 'C:\\windows', 19:55:40 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:40 INFO - 'TEST1': 'testie', 19:55:40 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:40 INFO - 'USERDOMAIN': 'T-W864-IX-272', 19:55:40 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 19:55:40 INFO - 'USERNAME': 'cltbld', 19:55:40 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-272', 19:55:40 INFO - 'WINDIR': 'C:\\windows', 19:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 19:55:41 INFO - Cleaning up... 19:55:41 INFO - Return code: 0 19:55:41 INFO - Running post-action listener: _resource_record_post_action 19:55:41 INFO - Running post-action listener: _start_resource_monitoring 19:55:41 INFO - Starting resource monitoring. 19:55:41 INFO - [mozharness: 2016-12-02 03:55:41.355000Z] Finished create-virtualenv step (success) 19:55:41 INFO - [mozharness: 2016-12-02 03:55:41.355000Z] Running install step. 19:55:41 INFO - Running pre-action listener: _resource_record_pre_action 19:55:41 INFO - Running main action method: install 19:55:41 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 19:55:41 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 19:55:41 INFO - Reading from file tmpfile_stdout 19:55:41 INFO - Using _rmtree_windows ... 19:55:41 INFO - Using _rmtree_windows ... 19:55:41 INFO - Detecting whether we're running mozinstall >=1.0... 19:55:41 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 19:55:41 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 19:55:41 INFO - Reading from file tmpfile_stdout 19:55:41 INFO - Output received: 19:55:41 INFO - Usage: mozinstall-script.py [options] installer 19:55:41 INFO - Options: 19:55:41 INFO - -h, --help show this help message and exit 19:55:41 INFO - -d DEST, --destination=DEST 19:55:41 INFO - Directory to install application into. [default: 19:55:41 INFO - "C:\slave\test"] 19:55:41 INFO - --app=APP Application being installed. [default: firefox] 19:55:41 INFO - Using _rmtree_windows ... 19:55:41 INFO - Using _rmtree_windows ... 19:55:41 INFO - mkdir: C:\slave\test\build\application 19:55:41 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'] 19:55:41 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 19:55:44 INFO - Reading from file tmpfile_stdout 19:55:44 INFO - Output received: 19:55:44 INFO - C:\slave\test\build\application\firefox\firefox.exe 19:55:44 INFO - Using _rmtree_windows ... 19:55:44 INFO - Using _rmtree_windows ... 19:55:44 INFO - Running post-action listener: _resource_record_post_action 19:55:44 INFO - [mozharness: 2016-12-02 03:55:44.289000Z] Finished install step (success) 19:55:44 INFO - [mozharness: 2016-12-02 03:55:44.290000Z] Running run-tests step. 19:55:44 INFO - Running pre-action listener: _resource_record_pre_action 19:55:44 INFO - Running main action method: run_tests 19:55:44 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 19:55:44 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 19:55:44 INFO - Python 2.7.3 19:55:44 INFO - Return code: 0 19:55:44 INFO - grabbing minidump binary from tooltool 19:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:44 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 0x023C5E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028865C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 19:55:44 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 19:55:44 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 19:55:44 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 19:55:44 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 19:55:44 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpkyfyiw 19:55:44 INFO - INFO - File integrity verified, renaming tmpkyfyiw to win32-minidump_stackwalk.exe 19:55:44 INFO - Return code: 0 19:55:44 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 19:55:44 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 19:55:44 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 19:55:44 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 19:55:44 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 19:55:44 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-272', '--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 19:55:44 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Graphics --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-272 --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 19:55:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:55:44 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Roaming', 19:55:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:55:44 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:55:44 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:55:44 INFO - 'COMPUTERNAME': 'T-W864-IX-272', 19:55:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:55:44 INFO - 'DCLOCATION': 'SCL3', 19:55:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:55:44 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:55:44 INFO - 'HOMEDRIVE': 'C:', 19:55:44 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-272', 19:55:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:55:44 INFO - 'KTS_VERSION': '1.19c', 19:55:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-272\\AppData\\Local', 19:55:44 INFO - 'LOGONSERVER': '\\\\T-W864-IX-272', 19:55:44 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 19:55:44 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 19:55:44 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:55:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:44 INFO - 'MOZ_NO_REMOTE': '1', 19:55:44 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 19:55:44 INFO - 'NO_EM_RESTART': '1', 19:55:44 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:55:44 INFO - 'OS': 'Windows_NT', 19:55:44 INFO - 'OURDRIVE': 'C:', 19:55:44 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 19:55:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:55:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:55:44 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:55:44 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:55:44 INFO - 'PROCESSOR_LEVEL': '6', 19:55:44 INFO - 'PROCESSOR_REVISION': '1e05', 19:55:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:55:44 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:55:44 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:55:44 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:55:44 INFO - 'PROMPT': '$P$G', 19:55:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:55:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:55:44 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:55:44 INFO - 'PWD': 'C:\\slave\\test', 19:55:44 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 19:55:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:55:44 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:55:44 INFO - 'SYSTEMDRIVE': 'C:', 19:55:44 INFO - 'SYSTEMROOT': 'C:\\windows', 19:55:44 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:44 INFO - 'TEST1': 'testie', 19:55:44 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:55:44 INFO - 'USERDOMAIN': 'T-W864-IX-272', 19:55:44 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-272', 19:55:44 INFO - 'USERNAME': 'cltbld', 19:55:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-272', 19:55:44 INFO - 'WINDIR': 'C:\\windows', 19:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:55:44 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-272', '--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 19:55:45 INFO - mozversion application_buildid: 20161201184344 19:55:45 INFO - mozversion application_changeset: 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 19:55:45 INFO - mozversion application_display_name: Nightly 19:55:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:55:45 INFO - mozversion application_name: Firefox 19:55:45 INFO - mozversion application_remotingname: firefox 19:55:45 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 19:55:45 INFO - mozversion application_vendor: Mozilla 19:55:45 INFO - mozversion application_version: 53.0a1 19:55:45 INFO - mozversion platform_buildid: 20161201184344 19:55:45 INFO - mozversion platform_changeset: 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 19:55:45 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 19:55:45 INFO - mozversion platform_version: 53.0a1 19:55:45 INFO - using testdate: 1480650945 19:55:45 INFO - actual date: 1480650945 19:55:45 INFO - starting webserver on 'localhost:49276' 19:55:45 INFO - SUITE-START | Running 2 tests 19:55:45 INFO - TEST-START | dromaeo_css 19:55:45 INFO - operating with platform_type : w8_ 19:55:45 INFO - Initialising browser for dromaeo_css test... 19:55:45 INFO - TEST-INFO | started process 3412 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbwqitg\profile http://localhost:49276/getInfo.html) 19:55:53 INFO - PROCESS | 3412 | __metrics Screen width/height:1600/1200 19:55:53 INFO - PROCESS | 3412 | colorDepth:24 19:55:53 INFO - PROCESS | 3412 | Browser inner width/height: 1010/674 19:55:53 INFO - PROCESS | 3412 | __metrics 19:55:54 INFO - PROCESS | 3412 | 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" 19:55:54 INFO - PROCESS | 3412 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:55:56 INFO - TEST-INFO | 3412: exit 0 19:55:56 INFO - Browser initialized. 19:55:56 INFO - Running cycle 1/1 for dromaeo_css test... 19:55:56 INFO - TEST-INFO | started process 3776 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbwqitg\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:55:56 INFO - PROCESS | 3776 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 19:56:07 INFO - PROCESS | 3776 | RSS: Main: 175595520 19:56:07 INFO - PROCESS | 3776 | 19:56:59 INFO - PROCESS | 3776 | 1480651019094 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] 19:59:09 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 19:59:10 INFO - PROCESS | 3776 | RSS: Main: 233156608 19:59:10 INFO - PROCESS | 3776 | 20:02:13 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 20:02:14 INFO - PROCESS | 3776 | RSS: Main: 235745280 20:02:14 INFO - PROCESS | 3776 | 20:05:16 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 20:05:17 INFO - PROCESS | 3776 | RSS: Main: 185815040 20:05:17 INFO - PROCESS | 3776 | 20:08:19 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 20:08:20 INFO - PROCESS | 3776 | RSS: Main: 200736768 20:08:20 INFO - PROCESS | 3776 | 20:11:23 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 20:11:24 INFO - PROCESS | 3776 | RSS: Main: 174845952 20:11:24 INFO - PROCESS | 3776 | 20:14:27 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 20:14:27 INFO - PROCESS | 3776 | RSS: Main: 266588160 20:14:27 INFO - PROCESS | 3776 | 20:14:27 INFO - PROCESS | 3776 | __start_tp_report 20:14:27 INFO - PROCESS | 3776 | _x_x_mozilla_page_load 20:14:27 INFO - PROCESS | 3776 | _x_x_mozilla_page_load_details 20:14:27 INFO - PROCESS | 3776 | |i|pagename|runs| 20:14:27 INFO - PROCESS | 3776 | |0;dojo.html;2608.2305719812657;2622.4755048990205;2624.291441310845;2627.684677838659;2630.3818602628367;4342.956570434295;4343.370211319357;4344.239758042346;4346.9347959780625;4356.8257269709175;4194.517630472496;4276.550962148976;4340.479142502896;4367.45406824147;4419.1382680377255;3962.9603703963026;4003.2794097062515;4042.8382864685377;4057.6348128668415;4100.65144462721;4013.799310034501;4049.1496785675045;4053.2298863215897;4087.8773636790943;4134.751914885116;3957.1887763008804;4043.97978010111;4084.836606535735;4103.220388126247;4126.5254495732925;3886.2616102940633;4050.574689657573;4069.0844559974066;4075.347944328923;4091.89770255743;4020.2763502569524;4029.798510074514;4035.2534781065597;4053.2298863215897;4081.9387709184384;4224.662027037861;4244.872653820359;4316.093620339732;4387.780610969438;4416.293393057128;4487.506374298824;4500.144972455223;4512.390827238313;4554.954450455486;4583.472900616439;4439.511653718088;4552.408186935677;4582.908341833145;4583.633309335245;4591.517890621503;4157.584241575818;4198.244316023145;4277.6791740619265;4277.893052673646;4302.913941721179;4548.976480291974;4604.447466304065;4608.5621865922685;4618.607418369409;4632.814687412466;4460.7063951454365;4467.5532446755715;4467.754273514988;4488.9102217956115;4491.797869095899;4555.2256116460285;4559.179347717442;4560.586218272346;4562.771861406916;4593.563611456906;4376.387305777193;4403.185410699031;4408.647308215335;4455.997400584907;4513.842015529441;4548.226801443762;4584.564466375689;4621.607163391082;4624.97687511567;4630.814767409333;3171.809691418476;3173.2384227785165;3187.2669286064333;3188.7289580385927;3205.5512228288057;2900.7244311790346;2903.3757742085554;2954.778391620637;2976.776741744378;2984.2390190501283;4238.131183107455;4274.08107256935;4283.657307415461;4299.763513006815;4300.61294483498;4605.0559635274685;4625.098105869323;4627.9074418511445;4654.790534425959;4668;4266.146770645883;4311.245532031882;4315.525292217853;4316.719413238129;4355.107203023373;3758.6241375862196;3772.6227377262603;3796.430535419709;3836.040989752562;3873.7869417182324;4654.232051711429;4691.577758001797;4692.131955588227;4695.929561056587;4760.571548560577;4668.696534725232;4677.204875171297;4677.672562920563;4678.625709943129;4722.905541889212;4481.036577135931;4525.411696479437;4705.411823522059;4710.081534100817;4738.05238952204;4488.483824360241;4498.572635599744;4502;4503.166914120898;4505.053938672784;4516.774161291856;4519.977400112978;4537.205988951854;4557.088582283623;4606.216943119744;4428.468583769968;4459;4463.732176069446;4466.977665111654;4504.819807207675;4411.139827733689;4417.403650507141;4418.6023257906945;4459.933101003552;4487.753173575485;4391.670624703224;4406.339049142526;4419.933700994423;4432.15789000089;4506.639468842551;4512.142692888472;4519.728816271035;4534.6599005074095;4536.115457485758;4579.244424669892;4456;4468.620167285687;4470.195364834361;4470.351798989063;4508.32375143731 20:14:27 INFO - PROCESS | 3776 | |1;ext.html;534.3000669123447;540.0764692376036;542.5767901037187;542.9819089207735;544.5262621519278;26013;26615.6007659885;28403.43193136136;28491.71508284919;32975.50536741945;32981;35856.64143358565;36171.638283617154;36236;36245.275094498094;7565.659545320474;7711.730089446871;7714.498557593766;7715.267049630276;7719.112302085276;6876.656167191621;7066.3993560547415;7592.658330375119;7734;7749.263819937125;7281.271872812729;7324.377427918634;7342.559446433204;8907.77730556738;9117.908820911805;9042;9055.683051093212;9064.184223419923;9112.134347237003;9127.132922372364;8849.070847560977;8909.73270801877;8911;8920.375573709844;8924.68763593271;27088.729112709014;27687.86156069207;31290.21774455634;32410.189745256557;32840.835795820865;2728.959065614017;2770.5567109262624;2820.5769134629763;2929.6777354490987;3134.420132275536;26086;26735.331616709544;28269.57595636067;28284.71715282862;28662;3459.8789042383646;3534.2401383702627;3547.787132772042;3559.1458050068054;3673.3938900081453;207808;210018;210739.94630026905;210768;210965;46602.30096548554;47128.764356178;47336.7633161832;47339.289910651365;47361.76319118451;47538.28692569614;49252.507474924794;49328.75335623299;49549.504504954486;49580;12549.184303020456;13090.280034597998;13091.083624146218;13116.344182791014;13150.145240559334;9847.704568862946;9957.551910163915;9968.053034961667;9974.750631234132;9975.650852220137;13825.239611821245;15550.455734049254;15831.762523562156;15843.445479408165;15862.206889655472;5383.757730902041;6681.933180668131;6709.597424154566;6710.228323742832;6799.218089919723;833.4832403909494;881.7310720230391;922.6078916460477;925.0934084596998;990.8810942686923;25750.227493175236;25813.48373032529;25939.351516211867;26326.21021369362;26461.603075953877;913.6436789652041;931.1014870649856;955.1308309438377;956.5982287439292;985.7973272607408;13807.930960345135;13915.930420348035;13953.3720982554;14033.649158770908;14066.788998165035;282507;282797;285325;285907;286896;45827.08345833065;45893.5410645896;46329.768351158025;46366.76816615895;46430.767846160554;1174.5771522251812;1181.2676140792764;1190.0717440396504;1199.1785626845638;1209.975800484003;24973.875130624958;25381.980640357408;25492.107776227742;25670.61494077628;25715.871420642776;38939.80530097331;39113.41329879997;39545;39548;39568.40647390234;234295;234920;235015;235157;237181;20462.590748185252;21113.577728445653;22232.77767222307;23230;23606.29181124569;36956.44565331576;37396;37728.245435091696;37801;37832.62167378401;31409.52885706762;32019.519707204876;32055.839720801247;32340;32733;31718.207044824063;31747.20631984219;31877.20306992251;32216.35567288688;32259.51610725794;30726.231844204074;30955.845220773754;31882.68117318797;31929.6807031936;31994.36011279808;27232;27939.720602793714;28353.29116772097;29325.56011659784;29963.700362996962;22809.201677941193;23003.769962300164;23122.190723324602;23468.178613748438;23541 20:14:27 INFO - PROCESS | 3776 | |2;jquery.html;313.37950857302553;325.1902762122315;331.9319539494403;332.77537662078095;342.28120946013377;12116;14813.18527480988;15270.312835922383;15449.304781284842;16057.678846423065;14407.42370305189;14495;14650.120992740443;14656.340464679088;14757.155355580553;4759.952400475986;4809.350737650408;5020.272060551218;5026.9497305027035;5030.170021946375;4819.686720363183;4957.950420495785;4961.677490963094;4963.801447942078;4969.950300496985;4936.111499930011;4936.72847993362;4937.654364194508;4938.061768264019;4942.9258561121615;4699.929501057487;4944.6785958912915;4955.554000139987;4965.3048573199785;4973.5772459341;4339.8481053163305;4343.261645520269;4344.174606824725;4349.26062569364;4354.303311470149;18267.99526026068;18557.072146392627;18608.34870779516;18691;18699.34552290663;1793.7937137229255;1890.3194849854042;1940.8835469871854;1946.6593346164364;2297.9540409191723;11449.942750286278;11975.520979160823;12245.693857653541;12531.624051278477;12531.812022819666;1651.8182999870005;1652.3803573659877;1657.1714142928536;1690.062015581352;1751.2819743904938;54325.72837135789;54895.17657235145;55212.17181742277;55530;56021.71989140069;8042.437029407885;8081.191880811872;8459.788505287293;8573.22840944318;8625.266852317623;11168.776624467466;11337.1497137715;11343.43282835855;11360.034397076175;11361.886381136248;6308.558400911984;6495;6507.381798729113;6579.671016449159;6588.308227636125;6266.091416744546;6279.96860015697;6389.9680501597195;6393.456556192683;6397.840053998594;5455.636090977256;5469.781208751685;5480.7533660985355;5498.202760599691;5511.972440137773;1585.1202582566787;1618.328393716618;1618.5190550646262;1620.933310029698;1622.9594260143356;861.4142383179372;869.4739682492128;879.8064425826308;967.5887747707196;987.5704068730125;15008.099514029193;15483.845161548466;15568.455104071303;15953.441629542911;16083.115428651536;811.4968719394013;861.7802460372691;863.8531449653574;893.3612467086065;919.3472634429496;8803.207711306013;9300.11648893354;9326.114019168168;9431.622735090657;9436.505262323371;265988;267276;268203;269277;269463;53401;54442.727786361604;54559.454405455435;54870.451295486535;54954;862.3403096631082;886.069626891774;888.4358432395346;889.6841621224502;890.2922176869405;13857.168569885838;14063.437462501386;14100;14308.427662893368;14596.854031459974;26951.921923122856;27101.86449067742;27128;27515.58726619062;28807.423851523272;37200.25599488049;39241.803790982005;39945.80027099962;41712.16575668409;41817.372739408325;6542.901856472252;6547.738090476518;6596.571222870498;6702.731890724316;6751.527393082633;7890;9844;10021.448820314661;10208.642697505551;10951.561937522729;8453.535055572003;8522.78693032679;8555.786105347415;8697.565121744014;8888.377813552988;8732.47605143668;8919.197272245528;9154.176124148858;9176.862347064665;9193.448393096436;8828.514431706319;8899.688510902088;8975.057618949917;9109.134632209929;9217;6710.362515561014;6746.359095885883;6850.691718872563;6928.7228510859;6977.651117444209;6505.21937367519;8620.13798620158;8844.46933184011;8963.372563920462;8983.371164018456 20:14:27 INFO - PROCESS | 3776 | |3;mootools.html;1083.8699356077273;1258.7104965857852;1274.1908887856212;1283.2813624370353;1511.6447634805818;5197.896042079156;5992.850178745528;6134.601250918688;6141.385861413862;6266.561340706153;6222.160008398865;6260.530460215479;6276.058591211309;6296.937030629692;6297.653629050412;1485.8365579786214;1523.5048609202;1821.6812057889883;1854.0822292964933;1855.6103218324101;1584.5721655153102;1585.8810589205798;1587.690400371928;1806.5122416947415;1869.8597605179598;1802.6394721055776;1806.223323970692;1806.304572739498;1811.6376724655056;1814.6733587954163;1738.9999999999936;1742.5730695979503;1744.084355713248;1746.9650606987916;1752.1414506891658;1790.9641807163914;1798.8667139702036;1813.4468986958973;1816.3642725046261;1816.809235030316;6136.110264011738;6168.19813424252;6215.56491045627;6217.56477046607;6219.782307619212;3629.546306711661;3735.962640373589;3742.288965096623;3743;3749.8687545935763;2227.8217742580555;2272.3183045086575;2395.700537432821;2406.470576473173;2408.771166739157;761.3110135327537;783.060327606874;803.907550631679;825.6665485241352;827.4042689263721;8007.6796928123385;8015.078265999368;8022.0774610919325;8025.759227223251;8036.437449378546;3185.9044228672715;3291.1772056985756;3372.7470439717117;3381.644927282649;3389.305192435545;6948.687309071104;7025.297470252934;7026.859462810715;7045.68294426752;7054.611996340148;3726;3727.086863718406;3729.664330210294;3730.0488375464624;3730.0861288984374;3399.4560870261134;3399.7790143640586;3401.778884372508;3405.438102713025;3406.2846802171325;2672.492226476963;2772.2930652683435;2887.5524293734507;2926.9121926342245;3018.72831445171;897.9775505612281;908.2915326045695;913.7578541686458;920.1856357123994;920.9953950230206;667.5794249622707;759.1876691939572;764.1479750078734;774.9341305989054;791.8337149198733;4082.078040602531;4310.418093557392;4313.9137217255475;4384.320430333303;4441.71128876622;805.5368163306123;809.6437567470412;861.3367706865679;889.3330002498126;919.6827094652334;2941.1617688958545;2958.3343747656604;3019.849007549614;3021.697830216961;3041.528563072727;7216.67524961378;7544.396448284124;7549.09410870688;7549.0941087069905;7558.395328373717;7490.925090749131;7496.287852653989;7500.512466689648;7502.512336698097;7511.248875112445;5698.715064246771;5829.358770535237;5833.358330583633;5835.9708201458725;5838.036723940502;4019.537753158424;4102.91794164121;4115.42384066225;4143.0678097427835;4210.221109094828;6685.231198412051;6700.530962832555;6712.093867327848;6741.460683145238;6753.257141714309;6671.299513551201;6936.653167341714;6977.860442791217;7028.0863487746265;7062.329078737512;5261.394939581844;5318.989392015505;5371.248025276543;5375.5162035417;5391.81128660495;5069.9746501267255;5231.921521177262;5982.581219314607;6045.244344456943;6058.969975104331;5109.284700142058;5142.742862856917;5252.527272545489;5254.789808407774;5283.2075188722;5232.189010703347;5250.711210883438;5251.606129540223;5282.709450980233;5306.8407947761625;4711.528847115261;4760.500147484603;4777.235642297216;4777.665563410667;4792.496787837366;3473.3400653876693;3518.4722291655435;3548.6628770267816;3571.0536707771944;3645.70834333258;3555.768875023115;3596.460530920383;3610.981945090258;3617.258462015228;3636.9818150909077 20:14:27 INFO - PROCESS | 3776 | |4;prototype.html;245.57229332989334;250.12331777121187;255.98720063996808;257.50687433564724;259.1525710925273;4368.672349573787;4519.751413672251;4523;4553.134904368168;4573.5197804230575;4397.648188144949;4451.955480445195;4505.504394516601;4508.887277818056;4513.142502924442;3489.5114683944266;3490.5985811631735;3491.668291512315;3497.912552186203;3515.8945231643092;3393.8303084845784;3527.5590551181103;3530.452779819132;3544.5746510418785;3557.6975957043683;3317.568716066908;3437.5874895012635;3488.5639295088113;3507.5264839246756;3511.4732790081566;3486.4073107571776;3488.89533314001;3491.2144767427126;3493.2489514754325;3494.178867966026;3050.7559395248327;3063.831489268089;3073.446779579675;3075.3695492424;3097.2566584019896;4187.350960601081;4403.295472724349;4445.466544014739;4445.932976085748;4461.42001539801;3863.5943225961432;3868.883933482;3871.7610364683314;3904.511936007999;3922.17634296798;4684;4689.742064186468;4694.460137084245;4718.386609740712;4722.8110875564935;3233.5958005249345;3251.9187020324443;3268.6894744999186;3271.8364081795817;3272.378248132871;4644.837430689943;4920.237363208673;4922.9753851231235;4984.551390374883;4999.500049995007;3279.967200327966;3294.8517316720804;3304.2235074757414;3315.1546355679147;3338.382399256145;3373.7132343750563;3375.042475364283;3375.729941604666;3378.2636064787603;3379.6113446953423;3894.2600905827803;3906.109478985587;3925.3130702127014;3926.332523471017;3930.504129877548;4442.511323754385;4693.249080147229;4712.69367491112;4718.504557021463;4767.046590681877;1082.626493859617;1120.165476719849;1136.4147464055852;1137.789508940832;1139.4416735799398;710.3287393413278;737.5611511150856;749.2133260076897;752.2176935986513;757.4016526943763;4320.308750599952;4325.935110973338;4363.454568178978;4382.780860956939;4386.670999675037;4699.929501057487;4700.670953033255;4734;4749.501302363271;4771.5228477152;4261.232978063978;4356.194104090753;4398.5924504159;4405.40527028847;4570.405847239837;2528.596628870994;2535.086010062428;2535.150724507274;2535.9095588896585;2538.2004668529353;4701.4358277006295;4785.210440277316;4790.520947905182;4798.256270278112;4813.638977076734;4689.038747056845;4815.593731735423;4840;4850.320955066293;4982.626303027288;4898.510148985144;4912.214045752662;4921.532454416824;4924.852254432301;4945.826896058621;4887.706737595613;4901.975490122527;4906.2640603909695;4938.7530623467965;4955.82654607087;4659.534046595313;4715.457722361835;4733.266343716592;4830.009847981085;4831.492693267156;4877.6585639004925;4885.340479035285;4898.975505122452;4908.6073114151495;4917.803287868445;3292.094673964679;3323.6842499962463;3355.815430151365;3355.969638368752;3356.7650264481254;4679.742614156118;4949.787302110862;4980.900381992267;4987.9002419950675;4993.201087825931;4752.643551733703;4765.189917714067;4774.037548834528;4782.2826576012485;4812.157872372391;4671.5897394902595;4768.332433459249;4781.856544303677;4841.685290456109;4850.563449289581;4510.188166129997;4718.386609740712;4722.362481065013;4744.525547445228;4758.5241475852135;4786.468330134324;4791.544803243686;4792.753883990257;4811.49479304668;4812.302216178565;4751.550777013044;4763.452202996561;4769.379980602638;4831.685940413862;4833.806647734052 20:14:27 INFO - PROCESS | 3776 | |5;yui.html;631.6494345638172;634.0710858592162;635.9332270111638;687.5737043033317;712.8895021271703;11480;12292.631221063371;12320.753584928318;12352.752944941107;12430;12684.492620295201;12836.550720724776;12864.228146311229;12909.806352904714;12912.289824059673;718.6730037832787;737.2516895351223;740.5519660605337;741.0699572037113;741.4290995933128;604.6764980735308;625.0218408191189;718.2601920022386;738.7931379213828;744.5049042386806;784.9607519624025;787.4409169489669;787.684926029587;788.0425283280813;788.1212448120361;781.03932163439;781.1797612506845;782.1474592693962;782.2373186143521;782.8786538086549;476.3236204589491;484.15998243048284;553.4824938682345;565.6775637886407;573.730346737033;11742;11763.7059073523;11893.702657433547;11904.821427678506;12026.338551379671;10546.314489558154;10877.07544858688;10909.509072091774;11242.550297988071;11986.460609272517;10409.427481488516;10441.164706823436;10455.68632941013;10488.426735989586;10540.262181647287;3911.8630847920185;3940.4680368150507;3980.661643760284;4060.045889216032;4098.918021639581;50998;51677.74161129208;52500.47499524994;53418.198727019124;54168.45831541713;8928.375013748975;9109.77225569366;9185.586648600829;9235.769105772275;9275.953620231856;15527.84472155264;16934.153292335333;16950.915245423694;16970.40603578869;16992.23534940906;6222.377762223832;6282.654454004982;6388.648624325707;6581.210254769362;6734.46124310054;3562.323158599858;3601.8019008954234;3608.1160115771804;3676.5955744868043;3683.3001729671278;2367.2188177901253;2470.542949554302;2472.6291056341693;2472.8763561822198;2473.4805690804774;403.7234494371365;408.6118187721676;408.62406585941005;438.2462165076064;458.8852786803299;474.6037059055658;562.825524087526;575.6862509932097;583.0816464069109;593.2021431175062;7478.588677622783;7488.438367122488;7669.846603067907;7670.578118203441;7778.299953004257;545.5117669685609;566.5495930735076;567.1294562846011;573.87087905221;577.7760098649526;3548.591911930161;3713.6100709425664;3742.2702572998005;3769.140164899891;3825.540935087807;60433.69783151056;61639.38360616426;62113.37886621076;62191;62212.377876221566;46108;49550;51677.95635763726;53346;54745.45254547483;39652.60347396547;42070.57929420728;44351.11297773962;46200;47938.04123917572;7476.5887876167335;7722.3049925506975;8049.87925181111;8084.231997960184;8278.751637450887;29100.854495727384;30802.229944251572;31139.820212584902;31144.844275778476;32305.676943230268;38053.4291985626;41935.16129677328;41949.370759438025;42052.57947420609;42585.36121958235;9734.172595329477;9750.561224744763;9904.702858914245;9936.105750482491;10194.541245643815;11238.86575135002;11493.252938558968;11533.826992595286;11685;12050.638480845588;10255.128314093086;10260.230482713678;10273.794524109326;10294.825302489773;10457.633982810565;9500.955870638774;9587.760305992406;9814;10120.848187277345;10197.23520735933;9974;10276.948615257175;10329.535170917177;10587.523561439908;10607.575696972035;8525.91474085276;8666.133386661535;8729.51987640686;9173.44959302444;9227.815443691223;8221.630026648934;8311.133200795228;8376.246137847624;8691.391602587759;8750.47497150173 20:14:27 INFO - PROCESS | 3776 | __end_tp_report 20:14:27 INFO - PROCESS | 3776 | __start_cc_report 20:14:27 INFO - PROCESS | 3776 | _x_x_mozilla_cycle_collect,1068 20:14:27 INFO - PROCESS | 3776 | __end_cc_report 20:14:27 INFO - PROCESS | 3776 | __startTimestamp1480652067361__endTimestamp 20:14:27 INFO - PROCESS | 3776 | 20:14:27 INFO - PROCESS | 3776 | ------- Summary: start ------- 20:14:27 INFO - PROCESS | 3776 | Number of tests: 6 20:14:27 INFO - PROCESS | 3776 | 20:14:27 INFO - PROCESS | 3776 | [#0] dojo.html Cycles:165 Average:4255.23 Median:4419.14 stddev:483.05 (10.9%) stddev-sans-first:466.93 20:14:27 INFO - PROCESS | 3776 | Values: 2608.2 2622.5 2624.3 2627.7 2630.4 4343.0 4343.4 4344.2 4346.9 4356.8 4194.5 4276.6 4340.5 4367.5 4419.1 3963.0 4003.3 4042.8 4057.6 4100.7 4013.8 4049.1 4053.2 4087.9 4134.8 3957.2 4044.0 4084.8 4103.2 4126.5 3886.3 4050.6 4069.1 4075.3 4091.9 4020.3 4029.8 4035.3 4053.2 4081.9 4224.7 4244.9 4316.1 4387.8 4416.3 4487.5 4500.1 4512.4 4555.0 4583.5 4439.5 4552.4 4582.9 4583.6 4591.5 4157.6 4198.2 4277.7 4277.9 4302.9 4549.0 4604.4 4608.6 4618.6 4632.8 4460.7 4467.6 4467.8 4488.9 4491.8 4555.2 4559.2 4560.6 4562.8 4593.6 4376.4 4403.2 4408.6 4456.0 4513.8 4548.2 4584.6 4621.6 4625.0 4630.8 3171.8 3173.2 3187.3 3188.7 3205.6 2900.7 2903.4 2954.8 2976.8 2984.2 4238.1 4274.1 4283.7 4299.8 4300.6 4605.1 4625.1 4627.9 4654.8 4668.0 4266.1 4311.2 4315.5 4316.7 4355.1 3758.6 3772.6 3796.4 3836.0 3873.8 4654.2 4691.6 4692.1 4695.9 4760.6 4668.7 4677.2 4677.7 4678.6 4722.9 4481.0 4525.4 4705.4 4710.1 4738.1 4488.5 4498.6 4502.0 4503.2 4505.1 4516.8 4520.0 4537.2 4557.1 4606.2 4428.5 4459.0 4463.7 4467.0 4504.8 4411.1 4417.4 4418.6 4459.9 4487.8 4391.7 4406.3 4419.9 4432.2 4506.6 4512.1 4519.7 4534.7 4536.1 4579.2 4456.0 4468.6 4470.2 4470.4 4508.3 20:14:27 INFO - PROCESS | 3776 | 20:14:27 INFO - PROCESS | 3776 | [#1] ext.html Cycles:180 Average:38943.77 Median:32375.09 stddev:64026.81 (197.8%) stddev-sans-first:64141.47 20:14:27 INFO - PROCESS | 3776 | Values: 534.3 540.1 542.6 543.0 544.5 26013.0 26615.6 28403.4 28491.7 32975.5 32981.0 35856.6 36171.6 36236.0 36245.3 7565.7 7711.7 7714.5 7715.3 7719.1 6876.7 7066.4 7592.7 7734.0 7749.3 7281.3 7324.4 7342.6 8907.8 9117.9 9042.0 9055.7 9064.2 9112.1 9127.1 8849.1 8909.7 8911.0 8920.4 8924.7 27088.7 27687.9 31290.2 32410.2 32840.8 2729.0 2770.6 2820.6 2929.7 3134.4 26086.0 26735.3 28269.6 28284.7 28662.0 3459.9 3534.2 3547.8 3559.1 3673.4 207808.0 210018.0 210739.9 210768.0 210965.0 46602.3 47128.8 47336.8 47339.3 47361.8 47538.3 49252.5 49328.8 49549.5 49580.0 12549.2 13090.3 13091.1 13116.3 13150.1 9847.7 9957.6 9968.1 9974.8 9975.7 13825.2 15550.5 15831.8 15843.4 15862.2 5383.8 6681.9 6709.6 6710.2 6799.2 833.5 881.7 922.6 925.1 990.9 25750.2 25813.5 25939.4 26326.2 26461.6 913.6 931.1 955.1 956.6 985.8 13807.9 13915.9 13953.4 14033.6 14066.8 282507.0 282797.0 285325.0 285907.0 286896.0 45827.1 45893.5 46329.8 46366.8 46430.8 1174.6 1181.3 1190.1 1199.2 1210.0 24973.9 25382.0 25492.1 25670.6 25715.9 38939.8 39113.4 39545.0 39548.0 39568.4 234295.0 234920.0 235015.0 235157.0 237181.0 20462.6 21113.6 22232.8 23230.0 23606.3 36956.4 37396.0 37728.2 37801.0 37832.6 31409.5 32019.5 32055.8 32340.0 32733.0 31718.2 31747.2 31877.2 32216.4 32259.5 30726.2 30955.8 31882.7 31929.7 31994.4 27232.0 27939.7 28353.3 29325.6 29963.7 22809.2 23003.8 23122.2 23468.2 23541.0 20:14:27 INFO - PROCESS | 3776 | 20:14:27 INFO - PROCESS | 3776 | [#2] jquery.html Cycles:180 Average:18691.54 Median:4962.74 stddev:44228.46 (891.2%) stddev-sans-first:44331.00 20:14:27 INFO - PROCESS | 3776 | Values: 313.4 325.2 331.9 332.8 342.3 12116.0 14813.2 15270.3 15449.3 16057.7 14407.4 14495.0 14650.1 14656.3 14757.2 4760.0 4809.4 5020.3 5026.9 5030.2 4819.7 4958.0 4961.7 4963.8 4970.0 4936.1 4936.7 4937.7 4938.1 4942.9 4699.9 4944.7 4955.6 4965.3 4973.6 4339.8 4343.3 4344.2 4349.3 4354.3 18268.0 18557.1 18608.3 18691.0 18699.3 1793.8 1890.3 1940.9 1946.7 2298.0 11449.9 11975.5 12245.7 12531.6 12531.8 1651.8 1652.4 1657.2 1690.1 1751.3 54325.7 54895.2 55212.2 55530.0 56021.7 8042.4 8081.2 8459.8 8573.2 8625.3 11168.8 11337.1 11343.4 11360.0 11361.9 6308.6 6495.0 6507.4 6579.7 6588.3 6266.1 6280.0 6390.0 6393.5 6397.8 5455.6 5469.8 5480.8 5498.2 5512.0 1585.1 1618.3 1618.5 1620.9 1623.0 861.4 869.5 879.8 967.6 987.6 15008.1 15483.8 15568.5 15953.4 16083.1 811.5 861.8 863.9 893.4 919.3 8803.2 9300.1 9326.1 9431.6 9436.5 265988.0 267276.0 268203.0 269277.0 269463.0 53401.0 54442.7 54559.5 54870.5 54954.0 862.3 886.1 888.4 889.7 890.3 13857.2 14063.4 14100.0 14308.4 14596.9 26951.9 27101.9 27128.0 27515.6 28807.4 37200.3 39241.8 39945.8 41712.2 41817.4 6542.9 6547.7 6596.6 6702.7 6751.5 7890.0 9844.0 10021.4 10208.6 10951.6 8453.5 8522.8 8555.8 8697.6 8888.4 8732.5 8919.2 9154.2 9176.9 9193.4 8828.5 8899.7 8975.1 9109.1 9217.0 6710.4 6746.4 6850.7 6928.7 6977.7 6505.2 8620.1 8844.5 8963.4 8983.4 20:14:27 INFO - PROCESS | 3776 | 20:14:27 INFO - PROCESS | 3776 | [#3] mootools.html Cycles:180 Average:4040.62 Median:5089.63 stddev:2184.24 (42.9%) stddev-sans-first:2179.06 20:14:27 INFO - PROCESS | 3776 | Values: 1083.9 1258.7 1274.2 1283.3 1511.6 5197.9 5992.9 6134.6 6141.4 6266.6 6222.2 6260.5 6276.1 6296.9 6297.7 1485.8 1523.5 1821.7 1854.1 1855.6 1584.6 1585.9 1587.7 1806.5 1869.9 1802.6 1806.2 1806.3 1811.6 1814.7 1739.0 1742.6 1744.1 1747.0 1752.1 1791.0 1798.9 1813.4 1816.4 1816.8 6136.1 6168.2 6215.6 6217.6 6219.8 3629.5 3736.0 3742.3 3743.0 3749.9 2227.8 2272.3 2395.7 2406.5 2408.8 761.3 783.1 803.9 825.7 827.4 8007.7 8015.1 8022.1 8025.8 8036.4 3185.9 3291.2 3372.7 3381.6 3389.3 6948.7 7025.3 7026.9 7045.7 7054.6 3726.0 3727.1 3729.7 3730.0 3730.1 3399.5 3399.8 3401.8 3405.4 3406.3 2672.5 2772.3 2887.6 2926.9 3018.7 898.0 908.3 913.8 920.2 921.0 667.6 759.2 764.1 774.9 791.8 4082.1 4310.4 4313.9 4384.3 4441.7 805.5 809.6 861.3 889.3 919.7 2941.2 2958.3 3019.8 3021.7 3041.5 7216.7 7544.4 7549.1 7549.1 7558.4 7490.9 7496.3 7500.5 7502.5 7511.2 5698.7 5829.4 5833.4 5836.0 5838.0 4019.5 4102.9 4115.4 4143.1 4210.2 6685.2 6700.5 6712.1 6741.5 6753.3 6671.3 6936.7 6977.9 7028.1 7062.3 5261.4 5319.0 5371.2 5375.5 5391.8 5070.0 5231.9 5982.6 6045.2 6059.0 5109.3 5142.7 5252.5 5254.8 5283.2 5232.2 5250.7 5251.6 5282.7 5306.8 4711.5 4760.5 4777.2 4777.7 4792.5 3473.3 3518.5 3548.7 3571.1 3645.7 3555.8 3596.5 3611.0 3617.3 3637.0 20:14:27 INFO - PROCESS | 3776 | 20:14:27 INFO - PROCESS | 3776 | [#4] prototype.html Cycles:180 Average:3937.23 Median:4511.67 stddev:1184.16 (26.2%) stddev-sans-first:1154.61 20:14:27 INFO - PROCESS | 3776 | Values: 245.6 250.1 256.0 257.5 259.2 4368.7 4519.8 4523.0 4553.1 4573.5 4397.6 4452.0 4505.5 4508.9 4513.1 3489.5 3490.6 3491.7 3497.9 3515.9 3393.8 3527.6 3530.5 3544.6 3557.7 3317.6 3437.6 3488.6 3507.5 3511.5 3486.4 3488.9 3491.2 3493.2 3494.2 3050.8 3063.8 3073.4 3075.4 3097.3 4187.4 4403.3 4445.5 4445.9 4461.4 3863.6 3868.9 3871.8 3904.5 3922.2 4684.0 4689.7 4694.5 4718.4 4722.8 3233.6 3251.9 3268.7 3271.8 3272.4 4644.8 4920.2 4923.0 4984.6 4999.5 3280.0 3294.9 3304.2 3315.2 3338.4 3373.7 3375.0 3375.7 3378.3 3379.6 3894.3 3906.1 3925.3 3926.3 3930.5 4442.5 4693.2 4712.7 4718.5 4767.0 1082.6 1120.2 1136.4 1137.8 1139.4 710.3 737.6 749.2 752.2 757.4 4320.3 4325.9 4363.5 4382.8 4386.7 4699.9 4700.7 4734.0 4749.5 4771.5 4261.2 4356.2 4398.6 4405.4 4570.4 2528.6 2535.1 2535.2 2535.9 2538.2 4701.4 4785.2 4790.5 4798.3 4813.6 4689.0 4815.6 4840.0 4850.3 4982.6 4898.5 4912.2 4921.5 4924.9 4945.8 4887.7 4902.0 4906.3 4938.8 4955.8 4659.5 4715.5 4733.3 4830.0 4831.5 4877.7 4885.3 4899.0 4908.6 4917.8 3292.1 3323.7 3355.8 3356.0 3356.8 4679.7 4949.8 4980.9 4987.9 4993.2 4752.6 4765.2 4774.0 4782.3 4812.2 4671.6 4768.3 4781.9 4841.7 4850.6 4510.2 4718.4 4722.4 4744.5 4758.5 4786.5 4791.5 4792.8 4811.5 4812.3 4751.6 4763.5 4769.4 4831.7 4833.8 20:14:27 INFO - PROCESS | 3776 | 20:14:27 INFO - PROCESS | 3776 | [#5] yui.html Cycles:180 Average:13243.08 Median:25017.08 stddev:16247.14 (64.9%) stddev-sans-first:16265.12 20:14:27 INFO - PROCESS | 3776 | Values: 631.6 634.1 635.9 687.6 712.9 11480.0 12292.6 12320.8 12352.8 12430.0 12684.5 12836.6 12864.2 12909.8 12912.3 718.7 737.3 740.6 741.1 741.4 604.7 625.0 718.3 738.8 744.5 785.0 787.4 787.7 788.0 788.1 781.0 781.2 782.1 782.2 782.9 476.3 484.2 553.5 565.7 573.7 11742.0 11763.7 11893.7 11904.8 12026.3 10546.3 10877.1 10909.5 11242.6 11986.5 10409.4 10441.2 10455.7 10488.4 10540.3 3911.9 3940.5 3980.7 4060.0 4098.9 50998.0 51677.7 52500.5 53418.2 54168.5 8928.4 9109.8 9185.6 9235.8 9276.0 15527.8 16934.2 16950.9 16970.4 16992.2 6222.4 6282.7 6388.6 6581.2 6734.5 3562.3 3601.8 3608.1 3676.6 3683.3 2367.2 2470.5 2472.6 2472.9 2473.5 403.7 408.6 408.6 438.2 458.9 474.6 562.8 575.7 583.1 593.2 7478.6 7488.4 7669.8 7670.6 7778.3 545.5 566.5 567.1 573.9 577.8 3548.6 3713.6 3742.3 3769.1 3825.5 60433.7 61639.4 62113.4 62191.0 62212.4 46108.0 49550.0 51678.0 53346.0 54745.5 39652.6 42070.6 44351.1 46200.0 47938.0 7476.6 7722.3 8049.9 8084.2 8278.8 29100.9 30802.2 31139.8 31144.8 32305.7 38053.4 41935.2 41949.4 42052.6 42585.4 9734.2 9750.6 9904.7 9936.1 10194.5 11238.9 11493.3 11533.8 11685.0 12050.6 10255.1 10260.2 10273.8 10294.8 10457.6 9501.0 9587.8 9814.0 10120.8 10197.2 9974.0 10276.9 10329.5 10587.5 10607.6 8525.9 8666.1 8729.5 9173.4 9227.8 8221.6 8311.1 8376.2 8691.4 8750.5 20:14:27 INFO - PROCESS | 3776 | -------- Summary: end -------- 20:14:27 INFO - PROCESS | 3776 | 20:14:28 INFO - TEST-INFO | 3776: exit 0 20:14:28 INFO - TEST-OK | dromaeo_css | took 1123162ms 20:14:28 INFO - TEST-START | kraken 20:14:28 INFO - operating with platform_type : w8_ 20:14:28 INFO - Initialising browser for kraken test... 20:14:28 INFO - TEST-INFO | started process 2864 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmppzasvg\profile http://localhost:49276/getInfo.html) 20:14:34 INFO - PROCESS | 2864 | __metrics Screen width/height:1600/1200 20:14:34 INFO - PROCESS | 2864 | colorDepth:24 20:14:34 INFO - PROCESS | 2864 | Browser inner width/height: 1010/674 20:14:34 INFO - PROCESS | 2864 | __metrics 20:14:35 INFO - PROCESS | 2864 | 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" 20:14:35 INFO - PROCESS | 2864 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:14:35 INFO - PROCESS | 2864 | console.error: 20:14:35 INFO - PROCESS | 2864 | Message: Error: Transaction canceled due to a closed connection. 20:14:35 INFO - PROCESS | 2864 | Stack: 20:14:35 INFO - PROCESS | 2864 | ConnectionData.prototype<.executeTransaction/promise<@resource://gre/modules/Sqlite.jsm:560:15 20:14:35 INFO - PROCESS | 2864 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:550:9 20:14:35 INFO - PROCESS | 2864 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 20:14:35 INFO - PROCESS | 2864 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:386:5 20:14:35 INFO - PROCESS | 2864 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 20:14:35 INFO - PROCESS | 2864 | Barrier/this.client.addBlocker/promise13.3% 20:15:35 INFO - TinderboxPrint: I/O read bytes / time
185,589,248 / 1,607,950 20:15:35 INFO - TinderboxPrint: I/O write bytes / time
422,054,912 / 4,108,480 20:15:35 INFO - TinderboxPrint: CPU idle
8,277.1 (86.7%) 20:15:35 INFO - TinderboxPrint: CPU user
1,225.1 (12.8%) 20:15:35 INFO - install - Wall time: 3s; CPU: 11.0%; Read bytes: 0; Write bytes: 33398272; Read time: 0; Write time: 45220 20:15:35 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 185589248; Write bytes: 331846144; Read time: 1607950; Write time: 3922520 20:15:36 INFO - Running post-run listener: _upload_blobber_files 20:15:36 INFO - Blob upload gear active. 20:15:36 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 20:15:36 INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:15:36 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', 'Graphics', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 20:15:36 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 Graphics -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 20:15:36 INFO - (blobuploader) - INFO - Open directory for files ... 20:15:36 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 20:15:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:15:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:15:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:15:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:15:37 INFO - (blobuploader) - INFO - Done attempting. 20:15:37 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 20:15:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:15:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:15:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:15:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:15:38 INFO - (blobuploader) - INFO - Done attempting. 20:15:38 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 20:15:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:15:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:15:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:15:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:15:42 INFO - (blobuploader) - INFO - Done attempting. 20:15:42 INFO - (blobuploader) - INFO - Iteration through files over. 20:15:42 INFO - Return code: 0 20:15:42 INFO - rmtree: C:\slave\test\build\uploaded_files.json 20:15:42 INFO - Using _rmtree_windows ... 20:15:42 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 20:15:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/920951165531a4505cde12bbe98d3607dc1cd78dfa7b1acf13abbdb8fdb55379ba883a71021ccbe1b5daeb619ba9146642125d51adbab4ae9bd5dd6e34d6bc0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f3f5d3f016ca5d71d24e49ee9da1ca8c34e1173f801ad9737af26e0b3c0b559c5aeb78ac46a2c1234c1348c7f30a57f3d164e218cd461f831c7c4aa7a6202ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2808362695d3166802dff1841b5bcb01cce9bf51743c7b8e4bc258863c94c8dc89fc356254326332e1f6f3e9523edc12063cd01f406618fbaf1cc926bbeca57"} 20:15:42 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 20:15:42 INFO - Writing to file C:\slave\test\properties\blobber_files 20:15:42 INFO - Contents: 20:15:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/920951165531a4505cde12bbe98d3607dc1cd78dfa7b1acf13abbdb8fdb55379ba883a71021ccbe1b5daeb619ba9146642125d51adbab4ae9bd5dd6e34d6bc0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f3f5d3f016ca5d71d24e49ee9da1ca8c34e1173f801ad9737af26e0b3c0b559c5aeb78ac46a2c1234c1348c7f30a57f3d164e218cd461f831c7c4aa7a6202ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2808362695d3166802dff1841b5bcb01cce9bf51743c7b8e4bc258863c94c8dc89fc356254326332e1f6f3e9523edc12063cd01f406618fbaf1cc926bbeca57"} 20:15:42 INFO - Running post-run listener: copy_logs_to_upload_dir 20:15:42 INFO - Copying logs to upload dir... 20:15:42 INFO - mkdir: C:\slave\test\build\upload\logs 20:15:42 INFO - Copying logs to upload dir... 20:15:42 INFO - Using _rmtree_windows ... 20:15:42 INFO - Using _rmtree_windows ... 20:15:42 INFO - Using _rmtree_windows ... 20:15:42 INFO - Using _rmtree_windows ... 20:15:42 INFO - Using _rmtree_windows ... 20:15:42 INFO - Using _rmtree_windows ... 20:15:42 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1377.537000 ========= master_lag: 0.40 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 57 secs) (at 2016-12-01 20:15:42.206996) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 20:15:42.207743) ========= '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-272\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-272 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-272 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-272\AppData\Local LOGONSERVER=\\T-W864-IX-272 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-272 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-272 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-272 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/920951165531a4505cde12bbe98d3607dc1cd78dfa7b1acf13abbdb8fdb55379ba883a71021ccbe1b5daeb619ba9146642125d51adbab4ae9bd5dd6e34d6bc0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f3f5d3f016ca5d71d24e49ee9da1ca8c34e1173f801ad9737af26e0b3c0b559c5aeb78ac46a2c1234c1348c7f30a57f3d164e218cd461f831c7c4aa7a6202ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2808362695d3166802dff1841b5bcb01cce9bf51743c7b8e4bc258863c94c8dc89fc356254326332e1f6f3e9523edc12063cd01f406618fbaf1cc926bbeca57"} build_url:https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/XBbRM0BISJa2v4uOtm9yAQ/artifacts/public/build/firefox-53.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/920951165531a4505cde12bbe98d3607dc1cd78dfa7b1acf13abbdb8fdb55379ba883a71021ccbe1b5daeb619ba9146642125d51adbab4ae9bd5dd6e34d6bc0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f3f5d3f016ca5d71d24e49ee9da1ca8c34e1173f801ad9737af26e0b3c0b559c5aeb78ac46a2c1234c1348c7f30a57f3d164e218cd461f831c7c4aa7a6202ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2808362695d3166802dff1841b5bcb01cce9bf51743c7b8e4bc258863c94c8dc89fc356254326332e1f6f3e9523edc12063cd01f406618fbaf1cc926bbeca57"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 20:15:42.332745) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 20:15:42.333096) ========= '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-272\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-272 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-272 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-272\AppData\Local LOGONSERVER=\\T-W864-IX-272 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-272 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-272 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-272 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 20:15:42.455617) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-12-01 20:15:42.455928) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-12-01 20:15:43.181450) ========= ========= Total master_lag: 0.58 =========