builder: autoland_win8_64_test-dromaeojs-pgo slave: t-w864-ix-032 starttime: 1478145440.35 results: success (0) buildid: 20161102183006 builduid: 6d0f5bd57f10495e9b90b1f5eadfaf00 revision: 10c5b8d1bef5a8220c13d77127cac8bd1487eb43 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 20:57:20.350960) ========= master: http://buildbot-master126.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 20:57:20.351441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 20:57:20.351840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 20:57:20.430581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 20:57:20.430982) ========= '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-032\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-032 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-032 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-032\AppData\Local LOGONSERVER=\\T-W864-IX-032 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-032 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-032 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-032 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --20:57:21-- 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% 30.16 MB/s 20:57:22 (30.16 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.294000 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 20:57:21.793645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-11-02 20:57:21.794129) ========= '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-032\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-032 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-032 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-032\AppData\Local LOGONSERVER=\\T-W864-IX-032 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-032 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-032 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-032 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=3.211000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-11-02 20:57:25.028005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 20:57:25.028624) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/autoland --rev 10c5b8d1bef5a8220c13d77127cac8bd1487eb43 --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 10c5b8d1bef5a8220c13d77127cac8bd1487eb43 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-032\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-032 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-032 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-032\AppData\Local LOGONSERVER=\\T-W864-IX-032 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-032 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-032 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-032 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-11-02 20:57:25,753 truncating revision to first 12 chars 2016-11-02 20:57:25,753 Setting DEBUG logging. 2016-11-02 20:57:25,753 attempt 1/10 2016-11-02 20:57:25,753 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/10c5b8d1bef5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-02 20:57:26,177 unpacking tar archive at: autoland-10c5b8d1bef5/testing/mozharness/ 2016-11-02 20:57:26,778 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.546000 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 20:57:26.628100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 20:57:26.628420) ========= script_repo_revision: 10c5b8d1bef5a8220c13d77127cac8bd1487eb43 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 20:57:26.628862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 20:57:26.629131) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 20:57:26.646859) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 3 secs) (at 2016-11-02 20:57:26.647480) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Autoland' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Autoland' in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-032\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-032 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-032 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-032\AppData\Local LOGONSERVER=\\T-W864-IX-032 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-032 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-032 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-032 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 20:57:27 INFO - MultiFileLogger online at 20161102 20:57:27 in C:\slave\test 20:57:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 20:57:27 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 20:57:27 INFO - {'append_to_log': False, 20:57:27 INFO - 'base_work_dir': 'C:\\slave\\test', 20:57:27 INFO - 'blob_upload_branch': 'Autoland', 20:57:27 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 20:57:27 INFO - 'branch': 'Autoland', 20:57:27 INFO - 'buildbot_json_path': 'buildprops.json', 20:57:27 INFO - 'config_files': ('talos/windows_config.py',), 20:57:27 INFO - 'default_actions': ('clobber', 20:57:27 INFO - 'read-buildbot-config', 20:57:27 INFO - 'download-and-extract', 20:57:27 INFO - 'populate-webroot', 20:57:27 INFO - 'create-virtualenv', 20:57:27 INFO - 'install', 20:57:27 INFO - 'run-tests'), 20:57:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:57:27 INFO - 'download_minidump_stackwalk': True, 20:57:27 INFO - 'download_symbols': 'ondemand', 20:57:27 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 20:57:27 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 20:57:27 INFO - 'hg': 'c:/mozilla-build/hg/hg', 20:57:27 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 20:57:27 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 20:57:27 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 20:57:27 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 20:57:27 INFO - 'C:/mozilla-build/tooltool.py'), 20:57:27 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 20:57:27 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 20:57:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:57:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:57:27 INFO - 'installer_path': 'installer.exe', 20:57:27 INFO - 'log_level': 'info', 20:57:27 INFO - 'log_name': 'talos', 20:57:27 INFO - 'log_to_console': True, 20:57:27 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 20:57:27 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 20:57:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 20:57:27 INFO - 'opt_config_files': (), 20:57:27 INFO - 'pip_index': False, 20:57:27 INFO - 'sps_profile': False, 20:57:27 INFO - 'sps_profile_interval': 0, 20:57:27 INFO - 'suite': 'dromaeojs', 20:57:27 INFO - 'system_bits': '32', 20:57:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:57:27 INFO - 'title': 'T-W864-IX-032', 20:57:27 INFO - 'use_talos_json': True, 20:57:27 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 20:57:27 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 20:57:27 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 20:57:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:57:27 INFO - 'work_dir': 'build'} 20:57:27 INFO - [mozharness: 2016-11-03 03:57:27.503000Z] Running clobber step. 20:57:27 INFO - Running pre-action listener: _resource_record_pre_action 20:57:27 INFO - Running main action method: clobber 20:57:27 INFO - rmtree: C:\slave\test\build 20:57:27 INFO - Using _rmtree_windows ... 20:57:27 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 20:58:58 INFO - Running post-action listener: _resource_record_post_action 20:58:58 INFO - [mozharness: 2016-11-03 03:58:58.902000Z] Finished clobber step (success) 20:58:58 INFO - [mozharness: 2016-11-03 03:58:58.902000Z] Running read-buildbot-config step. 20:58:58 INFO - Running pre-action listener: _resource_record_pre_action 20:58:58 INFO - Running main action method: read_buildbot_config 20:58:58 INFO - Using buildbot properties: 20:58:58 INFO - { 20:58:58 INFO - "project": "", 20:58:58 INFO - "product": "firefox", 20:58:58 INFO - "script_repo_revision": "production", 20:58:58 INFO - "builddir": "autoland_win8_64_test-dromaeojs", 20:58:58 INFO - "repository": "", 20:58:58 INFO - "buildername": "Windows 8 64-bit autoland pgo talos dromaeojs", 20:58:58 INFO - "buildid": "20161102183006", 20:58:58 INFO - "pgo_build": "True", 20:58:58 INFO - "basedir": "C:\\slave\\test", 20:58:58 INFO - "buildnumber": 114, 20:58:58 INFO - "slavename": "t-w864-ix-032", 20:58:58 INFO - "master": "http://buildbot-master126.bb.releng.scl3.mozilla.com:8201/", 20:58:58 INFO - "platform": "win8_64", 20:58:58 INFO - "scheduler": "tests-autoland-win64-pgo-talos", 20:58:58 INFO - "branch": "autoland", 20:58:58 INFO - "repo_path": "integration/autoland", 20:58:58 INFO - "revision": "10c5b8d1bef5a8220c13d77127cac8bd1487eb43", 20:58:58 INFO - "stage_platform": "win64-pgo", 20:58:58 INFO - "builduid": "6d0f5bd57f10495e9b90b1f5eadfaf00", 20:58:58 INFO - "slavebuilddir": "test" 20:58:58 INFO - } 20:58:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 20:58:58 INFO - Running post-action listener: _resource_record_post_action 20:58:58 INFO - [mozharness: 2016-11-03 03:58:58.905000Z] Finished read-buildbot-config step (success) 20:58:58 INFO - [mozharness: 2016-11-03 03:58:58.905000Z] Running download-and-extract step. 20:58:58 INFO - Running pre-action listener: _resource_record_pre_action 20:58:58 INFO - Running main action method: download_and_extract 20:58:58 INFO - mkdir: C:\slave\test\build\tests 20:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:58:58 INFO - trying https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 20:58:58 INFO - Downloading https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 20:58:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.test_packages.json'}, attempt #1 20:58:59 INFO - Downloaded 1218 bytes. 20:58:59 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 20:58:59 INFO - Using the following test package requirements: 20:58:59 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 20:58:59 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:58:59 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 20:58:59 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 20:58:59 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:58:59 INFO - u'jsshell-win64.zip'], 20:58:59 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:58:59 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 20:58:59 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 20:58:59 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:58:59 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 20:58:59 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:58:59 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 20:58:59 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:58:59 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 20:58:59 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 20:58:59 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 20:58:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 20:58:59 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 20:58:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 20:58:59 INFO - Fetch https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 20:59:00 INFO - Http code: 200 20:59:00 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 20:59:00 INFO - x-amz-cf-id: yJ32exsOFPAYLvF4k1kwVBhzKYbLUMdAayCoI2aDOecwg0BAkFDzoA== 20:59:00 INFO - x-amz-version-id: prJpdwkoEvTGtH5Vp2AfOHCw7P7FlCCr 20:59:00 INFO - Expected file size: 17432058 20:59:00 INFO - Obtained file size: 17432058 20:59:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip', u'firefox-52.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 20:59:23 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 20:59:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 20:59:23 INFO - Fetch https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 20:59:23 INFO - Http code: 200 20:59:23 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 20:59:23 INFO - x-amz-cf-id: aMgyELTfQWN2m1CqbcADFBmDbviO9uJr3mlnGr-652lJb0c4RXCLDA== 20:59:23 INFO - x-amz-version-id: prJpdwkoEvTGtH5Vp2AfOHCw7P7FlCCr 20:59:24 INFO - Expected file size: 17432058 20:59:24 INFO - Obtained file size: 17432058 20:59:32 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 20:59:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 20:59:32 INFO - Fetch https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 20:59:33 INFO - Http code: 200 20:59:33 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 20:59:33 INFO - x-amz-cf-id: OJ6KHJebU6oJaknMIPfpyArkzeDu-RRpUFL2-RGI0xxIHCFCD0yVyw== 20:59:33 INFO - x-amz-version-id: azFuSKG6S9iTb4VXhdzMgowMLhHVii69 20:59:33 INFO - Expected file size: 14409038 20:59:33 INFO - Obtained file size: 14409038 20:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:41 INFO - trying https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 20:59:41 INFO - Downloading https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 20:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip'}, attempt #1 20:59:42 INFO - Downloaded 57250713 bytes. 20:59:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 20:59:42 INFO - mkdir: C:\slave\test\properties 20:59:42 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 20:59:42 INFO - Writing to file C:\slave\test\properties\build_url 20:59:42 INFO - Contents: 20:59:42 INFO - build_url:https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 20:59:43 INFO - Running post-action listener: _resource_record_post_action 20:59:43 INFO - Running post-action listener: set_extra_try_arguments 20:59:43 INFO - [mozharness: 2016-11-03 03:59:43.499000Z] Finished download-and-extract step (success) 20:59:43 INFO - [mozharness: 2016-11-03 03:59:43.499000Z] Running populate-webroot step. 20:59:43 INFO - Running pre-action listener: _resource_record_pre_action 20:59:43 INFO - Running main action method: populate_webroot 20:59:43 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 20:59:43 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 20:59:43 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 20:59:43 INFO - u'--tppagecycles', 20:59:43 INFO - u'7'], 20:59:43 INFO - u'tests': [u'tsvgm']}}, 20:59:43 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 20:59:43 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 20:59:43 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 20:59:43 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 20:59:43 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 20:59:43 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 20:59:43 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:43 INFO - u'talos_options': [u'--disable-e10s'], 20:59:43 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 20:59:43 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:43 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 20:59:43 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:43 INFO - u'talos_options': [u'--disable-e10s'], 20:59:43 INFO - u'tests': [u'damp', u'tps']}, 20:59:43 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:43 INFO - u'tests': [u'damp', u'tps']}, 20:59:43 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 20:59:43 INFO - u'tests': [u'dromaeo_dom']}, 20:59:43 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 20:59:43 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 20:59:43 INFO - u'tests': [u'basic_compositor_video']}, 20:59:43 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 20:59:43 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 20:59:43 INFO - u'tests': [u'a11yr', 20:59:43 INFO - u'ts_paint', 20:59:43 INFO - u'tpaint', 20:59:43 INFO - u'sessionrestore', 20:59:43 INFO - u'sessionrestore_no_auto_restore', 20:59:43 INFO - u'tabpaint']}, 20:59:43 INFO - u'other-e10s': {u'tests': [u'a11yr', 20:59:43 INFO - u'ts_paint', 20:59:43 INFO - u'tpaint', 20:59:43 INFO - u'sessionrestore', 20:59:43 INFO - u'sessionrestore_no_auto_restore', 20:59:43 INFO - u'tabpaint']}, 20:59:43 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 20:59:43 INFO - u'ts_paint', 20:59:43 INFO - u'tpaint', 20:59:43 INFO - u'sessionrestore', 20:59:43 INFO - u'sessionrestore_no_auto_restore', 20:59:43 INFO - u'tabpaint']}, 20:59:43 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 20:59:43 INFO - u'ts_paint', 20:59:43 INFO - u'tpaint', 20:59:43 INFO - u'sessionrestore', 20:59:43 INFO - u'sessionrestore_no_auto_restore', 20:59:43 INFO - u'tabpaint']}, 20:59:43 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 20:59:43 INFO - u'tests': [u'a11yr', 20:59:43 INFO - u'ts_paint', 20:59:43 INFO - u'tpaint', 20:59:43 INFO - u'sessionrestore', 20:59:43 INFO - u'sessionrestore_no_auto_restore', 20:59:43 INFO - u'tabpaint']}, 20:59:43 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 20:59:43 INFO - u'tests': [u'a11yr', 20:59:43 INFO - u'ts_paint', 20:59:43 INFO - u'tpaint', 20:59:43 INFO - u'sessionrestore', 20:59:43 INFO - u'sessionrestore_no_auto_restore', 20:59:43 INFO - u'tabpaint']}, 20:59:43 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 20:59:43 INFO - u'tests': [u'tsvgx', 20:59:43 INFO - u'tsvgr_opacity', 20:59:43 INFO - u'tart', 20:59:43 INFO - u'tscrollx', 20:59:43 INFO - u'cart']}, 20:59:43 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 20:59:43 INFO - u'tsvgr_opacity', 20:59:43 INFO - u'tart', 20:59:43 INFO - u'tscrollx', 20:59:43 INFO - u'cart']}, 20:59:43 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:43 INFO - u'talos_options': [u'--disable-e10s'], 20:59:43 INFO - u'tests': [u'tp5o']}, 20:59:43 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:43 INFO - u'tests': [u'tp5o']}, 20:59:43 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:43 INFO - u'talos_options': [u'--disable-e10s', 20:59:43 INFO - u'--xperf_path', 20:59:43 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:59:43 INFO - u'tests': [u'tp5n']}, 20:59:43 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:43 INFO - u'talos_options': [u'--xperf_path', 20:59:43 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:59:43 INFO - u'tests': [u'tp5n']}}, 20:59:43 INFO - u'talos.zip': {u'path': u'', 20:59:43 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:59:43 INFO - Running post-action listener: _resource_record_post_action 20:59:43 INFO - [mozharness: 2016-11-03 03:59:43.513000Z] Finished populate-webroot step (success) 20:59:43 INFO - [mozharness: 2016-11-03 03:59:43.513000Z] Running create-virtualenv step. 20:59:43 INFO - Running pre-action listener: _resource_record_pre_action 20:59:43 INFO - Running main action method: create_virtualenv 20:59:43 INFO - Creating virtualenv C:\slave\test\build/venv 20:59:43 INFO - mkdir: C:\slave\test\build\venv\Scripts 20:59:43 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 20:59:43 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 20:59:43 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build 20:59:43 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 20:59:49 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 20:59:52 INFO - Installing distribute......................................................................................................................................................................................done. 20:59:54 INFO - Return code: 0 20:59:54 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 20:59:54 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 20:59:54 INFO - Reading from file tmpfile_stdout 20:59:54 INFO - Output received: 20:59:54 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 20:59:54 INFO - Using _rmtree_windows ... 20:59:54 INFO - Using _rmtree_windows ... 20:59:54 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 20:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:54 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 0x0227C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02323E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242FBA0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0236AE90>, '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 0x01CFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0280D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-032', 'USERDOMAIN': 'T-W864-IX-032', '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-032', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-032', '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-032\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 20:59:54 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build 20:59:54 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:59:54 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:59:54 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Roaming', 20:59:54 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:59:54 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:59:54 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:59:54 INFO - 'COMPUTERNAME': 'T-W864-IX-032', 20:59:54 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:59:54 INFO - 'DCLOCATION': 'SCL3', 20:59:54 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:59:54 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:59:54 INFO - 'HOMEDRIVE': 'C:', 20:59:54 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 20:59:54 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:59:54 INFO - 'KTS_VERSION': '1.19c', 20:59:54 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 20:59:54 INFO - 'LOGONSERVER': '\\\\T-W864-IX-032', 20:59:54 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:59:54 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:54 INFO - 'MOZ_NO_REMOTE': '1', 20:59:54 INFO - 'NO_EM_RESTART': '1', 20:59:54 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:59:54 INFO - 'OS': 'Windows_NT', 20:59:54 INFO - 'OURDRIVE': 'C:', 20:59:54 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 20:59:54 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:59:54 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:59:54 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:59:54 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:59:54 INFO - 'PROCESSOR_LEVEL': '6', 20:59:54 INFO - 'PROCESSOR_REVISION': '1e05', 20:59:54 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:59:54 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:59:54 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:59:54 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:59:54 INFO - 'PROMPT': '$P$G', 20:59:54 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:59:54 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:59:54 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:59:54 INFO - 'PWD': 'C:\\slave\\test', 20:59:54 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:59:54 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:59:54 INFO - 'SYSTEMDRIVE': 'C:', 20:59:54 INFO - 'SYSTEMROOT': 'C:\\windows', 20:59:54 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:59:54 INFO - 'TEST1': 'testie', 20:59:54 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:59:54 INFO - 'USERDOMAIN': 'T-W864-IX-032', 20:59:54 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 20:59:54 INFO - 'USERNAME': 'cltbld', 20:59:54 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-032', 20:59:54 INFO - 'WINDIR': 'C:\\windows', 20:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:59:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 20:59:55 INFO - Downloading/unpacking pip>=1.5 20:59:59 INFO - Running setup.py egg_info for package pip 20:59:59 INFO - warning: no files found matching 'pip\cacert.pem' 20:59:59 INFO - warning: no files found matching '*.html' under directory 'docs' 20:59:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 20:59:59 INFO - no previously-included directories found matching 'docs\_build\_sources' 20:59:59 INFO - Installing collected packages: pip 20:59:59 INFO - Found existing installation: pip 0.8.2 20:59:59 INFO - Uninstalling pip: 20:59:59 INFO - Successfully uninstalled pip 20:59:59 INFO - Running setup.py install for pip 20:59:59 INFO - warning: no files found matching 'pip\cacert.pem' 20:59:59 INFO - warning: no files found matching '*.html' under directory 'docs' 20:59:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 20:59:59 INFO - no previously-included directories found matching 'docs\_build\_sources' 20:59:59 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 20:59:59 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 20:59:59 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 20:59:59 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 20:59:59 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 20:59:59 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 20:59:59 INFO - Successfully installed pip 20:59:59 INFO - Cleaning up... 20:59:59 INFO - Return code: 0 20:59:59 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 20:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:59 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 0x0227C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02323E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242FBA0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0236AE90>, '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 0x01CFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0280D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-032', 'USERDOMAIN': 'T-W864-IX-032', '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-032', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-032', '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-032\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 20:59:59 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build 20:59:59 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:59:59 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:59:59 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Roaming', 20:59:59 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 20:59:59 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 20:59:59 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 20:59:59 INFO - 'COMPUTERNAME': 'T-W864-IX-032', 20:59:59 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:59:59 INFO - 'DCLOCATION': 'SCL3', 20:59:59 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:59:59 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:59:59 INFO - 'HOMEDRIVE': 'C:', 20:59:59 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 20:59:59 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:59:59 INFO - 'KTS_VERSION': '1.19c', 20:59:59 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 20:59:59 INFO - 'LOGONSERVER': '\\\\T-W864-IX-032', 20:59:59 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:59:59 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:59 INFO - 'MOZ_NO_REMOTE': '1', 20:59:59 INFO - 'NO_EM_RESTART': '1', 20:59:59 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:59:59 INFO - 'OS': 'Windows_NT', 20:59:59 INFO - 'OURDRIVE': 'C:', 20:59:59 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 20:59:59 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:59:59 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:59:59 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 20:59:59 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 20:59:59 INFO - 'PROCESSOR_LEVEL': '6', 20:59:59 INFO - 'PROCESSOR_REVISION': '1e05', 20:59:59 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:59:59 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 20:59:59 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 20:59:59 INFO - 'PROGRAMW6432': 'C:\\Program Files', 20:59:59 INFO - 'PROMPT': '$P$G', 20:59:59 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:59:59 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:59:59 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:59:59 INFO - 'PWD': 'C:\\slave\\test', 20:59:59 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:59:59 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:59:59 INFO - 'SYSTEMDRIVE': 'C:', 20:59:59 INFO - 'SYSTEMROOT': 'C:\\windows', 20:59:59 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:59:59 INFO - 'TEST1': 'testie', 20:59:59 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 20:59:59 INFO - 'USERDOMAIN': 'T-W864-IX-032', 20:59:59 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 20:59:59 INFO - 'USERNAME': 'cltbld', 20:59:59 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-032', 20:59:59 INFO - 'WINDIR': 'C:\\windows', 20:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 21:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:02 INFO - Downloading/unpacking psutil>=3.1.1 21:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:03 INFO - Installing collected packages: psutil 21:00:03 INFO - Successfully installed psutil 21:00:03 INFO - Cleaning up... 21:00:03 INFO - Return code: 0 21:00:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 21:00:03 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')]} 21:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:03 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')]} 21:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:03 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 0x0227C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02323E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242FBA0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0236AE90>, '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 0x01CFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0280D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-032', 'USERDOMAIN': 'T-W864-IX-032', '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-032', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-032', '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-032\\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 21:00:03 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 21:00:03 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 21:00:03 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 21:00:03 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Roaming', 21:00:03 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 21:00:03 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 21:00:03 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 21:00:03 INFO - 'COMPUTERNAME': 'T-W864-IX-032', 21:00:03 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 21:00:03 INFO - 'DCLOCATION': 'SCL3', 21:00:03 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 21:00:03 INFO - 'FP_NO_HOST_CHECK': 'NO', 21:00:03 INFO - 'HOMEDRIVE': 'C:', 21:00:03 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 21:00:03 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 21:00:03 INFO - 'KTS_VERSION': '1.19c', 21:00:03 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 21:00:03 INFO - 'LOGONSERVER': '\\\\T-W864-IX-032', 21:00:03 INFO - 'MONDIR': 'C:\\Monitor_config\\', 21:00:03 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 21:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:03 INFO - 'MOZ_NO_REMOTE': '1', 21:00:03 INFO - 'NO_EM_RESTART': '1', 21:00:03 INFO - 'NUMBER_OF_PROCESSORS': '8', 21:00:03 INFO - 'OS': 'Windows_NT', 21:00:03 INFO - 'OURDRIVE': 'C:', 21:00:03 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', 21:00:03 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 21:00:03 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 21:00:03 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 21:00:03 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 21:00:03 INFO - 'PROCESSOR_LEVEL': '6', 21:00:03 INFO - 'PROCESSOR_REVISION': '1e05', 21:00:03 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 21:00:03 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 21:00:03 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 21:00:03 INFO - 'PROGRAMW6432': 'C:\\Program Files', 21:00:03 INFO - 'PROMPT': '$P$G', 21:00:03 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 21:00:03 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 21:00:03 INFO - 'PUBLIC': 'C:\\Users\\Public', 21:00:03 INFO - 'PWD': 'C:\\slave\\test', 21:00:03 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 21:00:03 INFO - 'SLAVEDIR': 'C:\\slave\\', 21:00:03 INFO - 'SYSTEMDRIVE': 'C:', 21:00:03 INFO - 'SYSTEMROOT': 'C:\\windows', 21:00:03 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:03 INFO - 'TEST1': 'testie', 21:00:03 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:03 INFO - 'USERDOMAIN': 'T-W864-IX-032', 21:00:03 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 21:00:03 INFO - 'USERNAME': 'cltbld', 21:00:03 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-032', 21:00:03 INFO - 'WINDIR': 'C:\\windows', 21:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 21:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:00:04 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 21:00:04 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 21:00:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:00:05 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 21:00:05 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) 21:00:05 INFO - Installing collected packages: mozsystemmonitor 21:00:05 INFO - Running setup.py install for mozsystemmonitor 21:00:05 INFO - Successfully installed mozsystemmonitor 21:00:05 INFO - Cleaning up... 21:00:05 INFO - Return code: 0 21:00:05 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 21:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:05 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 0x0227C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02323E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242FBA0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0236AE90>, '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 0x01CFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0280D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-032', 'USERDOMAIN': 'T-W864-IX-032', '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-032', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-032', '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-032\\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 21:00:05 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 21:00:05 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 21:00:05 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 21:00:05 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Roaming', 21:00:05 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 21:00:05 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 21:00:05 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 21:00:05 INFO - 'COMPUTERNAME': 'T-W864-IX-032', 21:00:05 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 21:00:05 INFO - 'DCLOCATION': 'SCL3', 21:00:05 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 21:00:05 INFO - 'FP_NO_HOST_CHECK': 'NO', 21:00:05 INFO - 'HOMEDRIVE': 'C:', 21:00:05 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 21:00:05 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 21:00:05 INFO - 'KTS_VERSION': '1.19c', 21:00:05 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 21:00:05 INFO - 'LOGONSERVER': '\\\\T-W864-IX-032', 21:00:05 INFO - 'MONDIR': 'C:\\Monitor_config\\', 21:00:05 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 21:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:05 INFO - 'MOZ_NO_REMOTE': '1', 21:00:05 INFO - 'NO_EM_RESTART': '1', 21:00:05 INFO - 'NUMBER_OF_PROCESSORS': '8', 21:00:05 INFO - 'OS': 'Windows_NT', 21:00:05 INFO - 'OURDRIVE': 'C:', 21:00:05 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 21:00:05 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 21:00:05 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 21:00:05 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 21:00:05 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 21:00:05 INFO - 'PROCESSOR_LEVEL': '6', 21:00:05 INFO - 'PROCESSOR_REVISION': '1e05', 21:00:05 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 21:00:05 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 21:00:05 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 21:00:05 INFO - 'PROGRAMW6432': 'C:\\Program Files', 21:00:05 INFO - 'PROMPT': '$P$G', 21:00:05 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 21:00:05 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 21:00:05 INFO - 'PUBLIC': 'C:\\Users\\Public', 21:00:05 INFO - 'PWD': 'C:\\slave\\test', 21:00:05 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 21:00:05 INFO - 'SLAVEDIR': 'C:\\slave\\', 21:00:05 INFO - 'SYSTEMDRIVE': 'C:', 21:00:05 INFO - 'SYSTEMROOT': 'C:\\windows', 21:00:05 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:05 INFO - 'TEST1': 'testie', 21:00:05 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:05 INFO - 'USERDOMAIN': 'T-W864-IX-032', 21:00:05 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 21:00:05 INFO - 'USERNAME': 'cltbld', 21:00:05 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-032', 21:00:05 INFO - 'WINDIR': 'C:\\windows', 21:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 21:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:05 INFO - Downloading/unpacking jsonschema==2.5.1 21:00:05 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 21:00:05 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 21:00:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:00:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:00:06 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 21:00:06 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 21:00:07 INFO - Downloading functools32-3.2.3-2.tar.gz 21:00:07 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 21:00:07 INFO - warning: no files found matching '*.txt' 21:00:07 INFO - no previously-included directories found matching 'build' 21:00:07 INFO - no previously-included directories found matching 'dist' 21:00:07 INFO - no previously-included directories found matching '.git*' 21:00:07 INFO - Installing collected packages: jsonschema, functools32 21:00:07 INFO - Running setup.py install for functools32 21:00:07 INFO - warning: no files found matching '*.txt' 21:00:07 INFO - no previously-included directories found matching 'build' 21:00:07 INFO - no previously-included directories found matching 'dist' 21:00:07 INFO - no previously-included directories found matching '.git*' 21:00:07 INFO - Successfully installed jsonschema functools32 21:00:07 INFO - Cleaning up... 21:00:07 INFO - Return code: 0 21:00:07 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 21:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:07 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0227C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02323E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242FBA0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0236AE90>, '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 0x01CFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0280D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-032', 'USERDOMAIN': 'T-W864-IX-032', '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-032', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-032', '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-032\\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 21:00:07 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 21:00:07 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:00:07 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 21:00:07 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Roaming', 21:00:07 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 21:00:07 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 21:00:07 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 21:00:07 INFO - 'COMPUTERNAME': 'T-W864-IX-032', 21:00:07 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 21:00:07 INFO - 'DCLOCATION': 'SCL3', 21:00:07 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 21:00:07 INFO - 'FP_NO_HOST_CHECK': 'NO', 21:00:07 INFO - 'HOMEDRIVE': 'C:', 21:00:07 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 21:00:07 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 21:00:07 INFO - 'KTS_VERSION': '1.19c', 21:00:07 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 21:00:07 INFO - 'LOGONSERVER': '\\\\T-W864-IX-032', 21:00:07 INFO - 'MONDIR': 'C:\\Monitor_config\\', 21:00:07 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 21:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:07 INFO - 'MOZ_NO_REMOTE': '1', 21:00:07 INFO - 'NO_EM_RESTART': '1', 21:00:07 INFO - 'NUMBER_OF_PROCESSORS': '8', 21:00:07 INFO - 'OS': 'Windows_NT', 21:00:07 INFO - 'OURDRIVE': 'C:', 21:00:07 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 21:00:07 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 21:00:07 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 21:00:07 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 21:00:07 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 21:00:07 INFO - 'PROCESSOR_LEVEL': '6', 21:00:07 INFO - 'PROCESSOR_REVISION': '1e05', 21:00:07 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 21:00:07 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 21:00:07 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 21:00:07 INFO - 'PROGRAMW6432': 'C:\\Program Files', 21:00:07 INFO - 'PROMPT': '$P$G', 21:00:07 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 21:00:07 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 21:00:07 INFO - 'PUBLIC': 'C:\\Users\\Public', 21:00:07 INFO - 'PWD': 'C:\\slave\\test', 21:00:07 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 21:00:07 INFO - 'SLAVEDIR': 'C:\\slave\\', 21:00:07 INFO - 'SYSTEMDRIVE': 'C:', 21:00:07 INFO - 'SYSTEMROOT': 'C:\\windows', 21:00:07 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:07 INFO - 'TEST1': 'testie', 21:00:07 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:07 INFO - 'USERDOMAIN': 'T-W864-IX-032', 21:00:07 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 21:00:07 INFO - 'USERNAME': 'cltbld', 21:00:07 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-032', 21:00:07 INFO - 'WINDIR': 'C:\\windows', 21:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 21:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 21:00:08 INFO - Cleaning up... 21:00:08 INFO - Return code: 0 21:00:08 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 21:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:08 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 0x0227C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02323E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242FBA0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0236AE90>, '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 0x01CFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0280D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-032', 'USERDOMAIN': 'T-W864-IX-032', '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-032', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-032', '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-032\\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 21:00:08 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 21:00:08 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 21:00:08 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 21:00:08 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Roaming', 21:00:08 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 21:00:08 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 21:00:08 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 21:00:08 INFO - 'COMPUTERNAME': 'T-W864-IX-032', 21:00:08 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 21:00:08 INFO - 'DCLOCATION': 'SCL3', 21:00:08 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 21:00:08 INFO - 'FP_NO_HOST_CHECK': 'NO', 21:00:08 INFO - 'HOMEDRIVE': 'C:', 21:00:08 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 21:00:08 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 21:00:08 INFO - 'KTS_VERSION': '1.19c', 21:00:08 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 21:00:08 INFO - 'LOGONSERVER': '\\\\T-W864-IX-032', 21:00:08 INFO - 'MONDIR': 'C:\\Monitor_config\\', 21:00:08 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 21:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:08 INFO - 'MOZ_NO_REMOTE': '1', 21:00:08 INFO - 'NO_EM_RESTART': '1', 21:00:08 INFO - 'NUMBER_OF_PROCESSORS': '8', 21:00:08 INFO - 'OS': 'Windows_NT', 21:00:08 INFO - 'OURDRIVE': 'C:', 21:00:08 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', 21:00:08 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 21:00:08 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 21:00:08 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 21:00:08 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 21:00:08 INFO - 'PROCESSOR_LEVEL': '6', 21:00:08 INFO - 'PROCESSOR_REVISION': '1e05', 21:00:08 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 21:00:08 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 21:00:08 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 21:00:08 INFO - 'PROGRAMW6432': 'C:\\Program Files', 21:00:08 INFO - 'PROMPT': '$P$G', 21:00:08 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 21:00:08 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 21:00:08 INFO - 'PUBLIC': 'C:\\Users\\Public', 21:00:08 INFO - 'PWD': 'C:\\slave\\test', 21:00:08 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 21:00:08 INFO - 'SLAVEDIR': 'C:\\slave\\', 21:00:08 INFO - 'SYSTEMDRIVE': 'C:', 21:00:08 INFO - 'SYSTEMROOT': 'C:\\windows', 21:00:08 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:08 INFO - 'TEST1': 'testie', 21:00:08 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:08 INFO - 'USERDOMAIN': 'T-W864-IX-032', 21:00:08 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 21:00:08 INFO - 'USERNAME': 'cltbld', 21:00:08 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-032', 21:00:08 INFO - 'WINDIR': 'C:\\windows', 21:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 21:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:08 INFO - Downloading/unpacking blobuploader==1.2.4 21:00:08 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 21:00:08 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 21:00:09 INFO - Downloading blobuploader-1.2.4.tar.gz 21:00:09 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 21:00:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:00:09 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 21:00:09 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 21:00:09 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 21:00:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:00:10 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 21:00:10 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 21:00:10 INFO - Downloading docopt-0.6.1.tar.gz 21:00:10 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 21:00:10 INFO - Installing collected packages: blobuploader, requests, docopt 21:00:10 INFO - Running setup.py install for blobuploader 21:00:10 INFO - Running setup.py install for requests 21:00:11 INFO - Running setup.py install for docopt 21:00:11 INFO - Successfully installed blobuploader requests docopt 21:00:11 INFO - Cleaning up... 21:00:12 INFO - Return code: 0 21:00:12 INFO - Installing None into virtualenv C:\slave\test\build/venv 21:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:12 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 0x0227C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02323E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242FBA0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0236AE90>, '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 0x01CFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0280D520>, '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-032', 'USERDOMAIN': 'T-W864-IX-032', '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-032', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-032', '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-032\\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 21:00:12 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 21:00:12 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 21:00:12 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 21:00:12 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Roaming', 21:00:12 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 21:00:12 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 21:00:12 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 21:00:12 INFO - 'COMPUTERNAME': 'T-W864-IX-032', 21:00:12 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 21:00:12 INFO - 'DCLOCATION': 'SCL3', 21:00:12 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 21:00:12 INFO - 'FP_NO_HOST_CHECK': 'NO', 21:00:12 INFO - 'HOMEDRIVE': 'C:', 21:00:12 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 21:00:12 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 21:00:12 INFO - 'KTS_VERSION': '1.19c', 21:00:12 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 21:00:12 INFO - 'LOGONSERVER': '\\\\T-W864-IX-032', 21:00:12 INFO - 'MONDIR': 'C:\\Monitor_config\\', 21:00:12 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 21:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:12 INFO - 'MOZ_NO_REMOTE': '1', 21:00:12 INFO - 'NO_EM_RESTART': '1', 21:00:12 INFO - 'NUMBER_OF_PROCESSORS': '8', 21:00:12 INFO - 'OS': 'Windows_NT', 21:00:12 INFO - 'OURDRIVE': 'C:', 21:00:12 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', 21:00:12 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 21:00:12 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 21:00:12 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 21:00:12 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 21:00:12 INFO - 'PROCESSOR_LEVEL': '6', 21:00:12 INFO - 'PROCESSOR_REVISION': '1e05', 21:00:12 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 21:00:12 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 21:00:12 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 21:00:12 INFO - 'PROGRAMW6432': 'C:\\Program Files', 21:00:12 INFO - 'PROMPT': '$P$G', 21:00:12 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 21:00:12 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 21:00:12 INFO - 'PUBLIC': 'C:\\Users\\Public', 21:00:12 INFO - 'PWD': 'C:\\slave\\test', 21:00:12 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 21:00:12 INFO - 'SLAVEDIR': 'C:\\slave\\', 21:00:12 INFO - 'SYSTEMDRIVE': 'C:', 21:00:12 INFO - 'SYSTEMROOT': 'C:\\windows', 21:00:12 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:12 INFO - 'TEST1': 'testie', 21:00:12 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:12 INFO - 'USERDOMAIN': 'T-W864-IX-032', 21:00:12 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 21:00:12 INFO - 'USERNAME': 'cltbld', 21:00:12 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-032', 21:00:12 INFO - 'WINDIR': 'C:\\windows', 21:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 21:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 21:00:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-naolkv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 21:00:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 21:00:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kgvsda-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 21:00:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 21:00:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mvc4xl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 21:00:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 21:00:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cexiuo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 21:00:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 21:00:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hiio52-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 21:00:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 21:00:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rm5xoz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 21:00:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 21:00:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-u4hsdx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 21:00:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 21:00:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9r5tdz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 21:00:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 21:00:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jzmebu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 21:00:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 21:00:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xjwiew-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 21:00:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 21:00:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mlndkn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 21:00:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 21:00:14 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lrmo9y-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 21:00:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 21:00:14 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-03jdkg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 21:00:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 21:00:14 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rhk33p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 21:00:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 21:00:14 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-soz33p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 21:00:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 21:00:14 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-degaio-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 21:00:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 21:00:14 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-thgvlt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 21:00:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:00:14 INFO - Running setup.py install for manifestparser 21:00:14 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 21:00:14 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 21:00:15 INFO - Running setup.py install for mozcrash 21:00:15 INFO - Running setup.py install for mozdebug 21:00:16 INFO - Running setup.py install for mozdevice 21:00:16 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 21:00:16 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 21:00:16 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 21:00:16 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 21:00:17 INFO - Running setup.py install for mozfile 21:00:17 INFO - Running setup.py install for mozhttpd 21:00:17 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 21:00:17 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 21:00:18 INFO - Running setup.py install for mozinfo 21:00:18 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 21:00:18 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 21:00:18 INFO - Running setup.py install for mozInstall 21:00:18 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 21:00:18 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 21:00:18 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 21:00:18 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 21:00:18 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 21:00:18 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 21:00:18 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 21:00:18 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 21:00:18 INFO - Running setup.py install for mozleak 21:00:19 INFO - Running setup.py install for mozlog 21:00:19 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 21:00:19 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 21:00:20 INFO - Running setup.py install for moznetwork 21:00:20 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 21:00:20 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 21:00:20 INFO - Running setup.py install for mozprocess 21:00:20 INFO - Running setup.py install for mozprofile 21:00:21 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 21:00:21 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 21:00:21 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 21:00:21 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 21:00:21 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 21:00:21 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 21:00:21 INFO - Running setup.py install for mozrunner 21:00:21 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 21:00:21 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 21:00:22 INFO - Running setup.py install for mozscreenshot 21:00:22 INFO - Running setup.py install for moztest 21:00:22 INFO - Running setup.py install for mozversion 21:00:23 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 21:00:23 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 21:00:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:00:23 INFO - Cleaning up... 21:00:23 INFO - Return code: 0 21:00:23 INFO - Installing None into virtualenv C:\slave\test\build/venv 21:00:23 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')]} 21:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:23 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')]} 21:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:23 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 0x0227C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02323E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242FBA0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0236AE90>, '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 0x01CFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0280D520>, '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-032', 'USERDOMAIN': 'T-W864-IX-032', '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-032', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-032', '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-032\\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 21:00:23 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 21:00:23 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 21:00:23 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 21:00:23 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Roaming', 21:00:23 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 21:00:23 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 21:00:23 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 21:00:23 INFO - 'COMPUTERNAME': 'T-W864-IX-032', 21:00:23 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 21:00:23 INFO - 'DCLOCATION': 'SCL3', 21:00:23 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 21:00:23 INFO - 'FP_NO_HOST_CHECK': 'NO', 21:00:23 INFO - 'HOMEDRIVE': 'C:', 21:00:23 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 21:00:23 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 21:00:23 INFO - 'KTS_VERSION': '1.19c', 21:00:23 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 21:00:23 INFO - 'LOGONSERVER': '\\\\T-W864-IX-032', 21:00:23 INFO - 'MONDIR': 'C:\\Monitor_config\\', 21:00:23 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 21:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:23 INFO - 'MOZ_NO_REMOTE': '1', 21:00:23 INFO - 'NO_EM_RESTART': '1', 21:00:23 INFO - 'NUMBER_OF_PROCESSORS': '8', 21:00:23 INFO - 'OS': 'Windows_NT', 21:00:23 INFO - 'OURDRIVE': 'C:', 21:00:23 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', 21:00:23 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 21:00:23 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 21:00:23 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 21:00:23 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 21:00:23 INFO - 'PROCESSOR_LEVEL': '6', 21:00:23 INFO - 'PROCESSOR_REVISION': '1e05', 21:00:23 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 21:00:23 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 21:00:23 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 21:00:23 INFO - 'PROGRAMW6432': 'C:\\Program Files', 21:00:23 INFO - 'PROMPT': '$P$G', 21:00:23 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 21:00:23 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 21:00:23 INFO - 'PUBLIC': 'C:\\Users\\Public', 21:00:23 INFO - 'PWD': 'C:\\slave\\test', 21:00:23 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 21:00:23 INFO - 'SLAVEDIR': 'C:\\slave\\', 21:00:23 INFO - 'SYSTEMDRIVE': 'C:', 21:00:23 INFO - 'SYSTEMROOT': 'C:\\windows', 21:00:23 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:23 INFO - 'TEST1': 'testie', 21:00:23 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:23 INFO - 'USERDOMAIN': 'T-W864-IX-032', 21:00:23 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 21:00:23 INFO - 'USERNAME': 'cltbld', 21:00:23 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-032', 21:00:23 INFO - 'WINDIR': 'C:\\windows', 21:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 21:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 21:00:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qz5xe8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 21:00:23 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)) 21:00:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 21:00:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qoxaln-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 21:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 21:00:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 21:00:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3i8kmx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 21:00:24 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)) 21:00:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 21:00:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mgc7pq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 21:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 21:00:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 21:00:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6pzw11-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 21:00:24 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)) 21:00:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 21:00:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5rw1kv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 21:00:24 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)) 21:00:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 21:00:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pqmoue-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 21:00:24 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)) 21:00:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 21:00:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vkolse-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 21:00:24 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)) 21:00:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 21:00:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gugppw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 21:00:24 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)) 21:00:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 21:00:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-an9hlw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 21:00:24 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)) 21:00:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 21:00:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-b5exwf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 21:00:25 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)) 21:00:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 21:00:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qdi3gu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 21:00:25 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)) 21:00:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 21:00:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vscqag-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 21:00:25 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)) 21:00:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 21:00:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uxq0vs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 21:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 21:00:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 21:00:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lxmjch-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 21:00:25 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)) 21:00:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 21:00:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fcuqoa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 21:00:25 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)) 21:00:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 21:00:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8wuwm6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 21:00:25 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)) 21:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 21:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 21:00:25 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)) 21:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 21:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 21:00:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 21:00:25 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 21:00:25 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 21:00:26 INFO - Downloading blessings-1.6.tar.gz 21:00:26 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 21:00:27 INFO - Installing collected packages: blessings 21:00:27 INFO - Running setup.py install for blessings 21:00:27 INFO - Successfully installed blessings 21:00:27 INFO - Cleaning up... 21:00:30 INFO - Return code: 0 21:00:30 INFO - Done creating virtualenv C:\slave\test\build/venv. 21:00:30 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 21:00:30 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 21:00:30 INFO - Reading from file tmpfile_stdout 21:00:30 INFO - Using _rmtree_windows ... 21:00:30 INFO - Using _rmtree_windows ... 21:00:30 INFO - Current package versions: 21:00:30 INFO - blessings == 1.6 21:00:30 INFO - blobuploader == 1.2.4 21:00:30 INFO - docopt == 0.6.1 21:00:30 INFO - functools32 == 3.2.3-2 21:00:30 INFO - jsonschema == 2.5.1 21:00:30 INFO - manifestparser == 1.1 21:00:30 INFO - mozInstall == 1.12 21:00:30 INFO - mozcrash == 0.17 21:00:30 INFO - mozdebug == 0.1 21:00:30 INFO - mozdevice == 0.48 21:00:30 INFO - mozfile == 1.2 21:00:30 INFO - mozhttpd == 0.7 21:00:30 INFO - mozinfo == 0.9 21:00:30 INFO - mozleak == 0.1 21:00:30 INFO - mozlog == 3.4 21:00:30 INFO - moznetwork == 0.27 21:00:30 INFO - mozprocess == 0.23 21:00:30 INFO - mozprofile == 0.28 21:00:30 INFO - mozrunner == 6.12 21:00:30 INFO - mozscreenshot == 0.1 21:00:30 INFO - mozsystemmonitor == 0.3 21:00:30 INFO - moztest == 0.7 21:00:30 INFO - mozversion == 1.4 21:00:30 INFO - psutil == 3.1.1 21:00:30 INFO - requests == 1.2.3 21:00:30 INFO - Installing None into virtualenv C:\slave\test\build/venv 21:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:30 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 0x0227C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02323E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242FBA0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0236AE90>, '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 0x01CFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0280D520>, '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-032', 'USERDOMAIN': 'T-W864-IX-032', '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-032', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-032', '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-032\\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 21:00:30 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 21:00:30 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 21:00:30 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 21:00:30 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Roaming', 21:00:30 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 21:00:30 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 21:00:30 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 21:00:30 INFO - 'COMPUTERNAME': 'T-W864-IX-032', 21:00:30 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 21:00:30 INFO - 'DCLOCATION': 'SCL3', 21:00:30 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 21:00:30 INFO - 'FP_NO_HOST_CHECK': 'NO', 21:00:30 INFO - 'HOMEDRIVE': 'C:', 21:00:30 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 21:00:30 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 21:00:30 INFO - 'KTS_VERSION': '1.19c', 21:00:30 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 21:00:30 INFO - 'LOGONSERVER': '\\\\T-W864-IX-032', 21:00:30 INFO - 'MONDIR': 'C:\\Monitor_config\\', 21:00:30 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 21:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:30 INFO - 'MOZ_NO_REMOTE': '1', 21:00:30 INFO - 'NO_EM_RESTART': '1', 21:00:30 INFO - 'NUMBER_OF_PROCESSORS': '8', 21:00:30 INFO - 'OS': 'Windows_NT', 21:00:30 INFO - 'OURDRIVE': 'C:', 21:00:30 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 21:00:30 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 21:00:30 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 21:00:30 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 21:00:30 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 21:00:30 INFO - 'PROCESSOR_LEVEL': '6', 21:00:30 INFO - 'PROCESSOR_REVISION': '1e05', 21:00:30 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 21:00:30 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 21:00:30 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 21:00:30 INFO - 'PROGRAMW6432': 'C:\\Program Files', 21:00:30 INFO - 'PROMPT': '$P$G', 21:00:30 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 21:00:30 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 21:00:30 INFO - 'PUBLIC': 'C:\\Users\\Public', 21:00:30 INFO - 'PWD': 'C:\\slave\\test', 21:00:30 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 21:00:30 INFO - 'SLAVEDIR': 'C:\\slave\\', 21:00:30 INFO - 'SYSTEMDRIVE': 'C:', 21:00:30 INFO - 'SYSTEMROOT': 'C:\\windows', 21:00:30 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:30 INFO - 'TEST1': 'testie', 21:00:30 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:30 INFO - 'USERDOMAIN': 'T-W864-IX-032', 21:00:30 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 21:00:30 INFO - 'USERNAME': 'cltbld', 21:00:30 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-032', 21:00:30 INFO - 'WINDIR': 'C:\\windows', 21:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 21:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:30 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)) 21:00:30 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)) 21:00:30 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)) 21:00:30 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)) 21:00:30 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)) 21:00:30 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)) 21:00:30 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)) 21:00:30 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)) 21:00:30 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)) 21:00:30 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)) 21:00:30 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)) 21:00:30 INFO - Cleaning up... 21:00:30 INFO - Return code: 0 21:00:30 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 21:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:30 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0227C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02323E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242FBA0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0236AE90>, '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 0x01CFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0280D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-032', 'USERDOMAIN': 'T-W864-IX-032', '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-032', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-032', '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-032\\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 21:00:30 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 21:00:30 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:00:30 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 21:00:30 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Roaming', 21:00:30 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 21:00:30 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 21:00:30 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 21:00:30 INFO - 'COMPUTERNAME': 'T-W864-IX-032', 21:00:30 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 21:00:30 INFO - 'DCLOCATION': 'SCL3', 21:00:30 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 21:00:30 INFO - 'FP_NO_HOST_CHECK': 'NO', 21:00:30 INFO - 'HOMEDRIVE': 'C:', 21:00:30 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 21:00:30 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 21:00:30 INFO - 'KTS_VERSION': '1.19c', 21:00:30 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 21:00:30 INFO - 'LOGONSERVER': '\\\\T-W864-IX-032', 21:00:30 INFO - 'MONDIR': 'C:\\Monitor_config\\', 21:00:30 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 21:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:30 INFO - 'MOZ_NO_REMOTE': '1', 21:00:30 INFO - 'NO_EM_RESTART': '1', 21:00:30 INFO - 'NUMBER_OF_PROCESSORS': '8', 21:00:30 INFO - 'OS': 'Windows_NT', 21:00:30 INFO - 'OURDRIVE': 'C:', 21:00:30 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 21:00:30 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 21:00:30 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 21:00:30 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 21:00:30 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 21:00:30 INFO - 'PROCESSOR_LEVEL': '6', 21:00:30 INFO - 'PROCESSOR_REVISION': '1e05', 21:00:30 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 21:00:30 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 21:00:30 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 21:00:30 INFO - 'PROGRAMW6432': 'C:\\Program Files', 21:00:30 INFO - 'PROMPT': '$P$G', 21:00:30 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 21:00:30 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 21:00:30 INFO - 'PUBLIC': 'C:\\Users\\Public', 21:00:30 INFO - 'PWD': 'C:\\slave\\test', 21:00:30 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 21:00:30 INFO - 'SLAVEDIR': 'C:\\slave\\', 21:00:30 INFO - 'SYSTEMDRIVE': 'C:', 21:00:30 INFO - 'SYSTEMROOT': 'C:\\windows', 21:00:30 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:30 INFO - 'TEST1': 'testie', 21:00:30 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:30 INFO - 'USERDOMAIN': 'T-W864-IX-032', 21:00:30 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 21:00:30 INFO - 'USERNAME': 'cltbld', 21:00:30 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-032', 21:00:30 INFO - 'WINDIR': 'C:\\windows', 21:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 21:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 21:00:31 INFO - Cleaning up... 21:00:31 INFO - Return code: 0 21:00:31 INFO - Running post-action listener: _resource_record_post_action 21:00:31 INFO - Running post-action listener: _start_resource_monitoring 21:00:31 INFO - Starting resource monitoring. 21:00:31 INFO - [mozharness: 2016-11-03 04:00:31.296000Z] Finished create-virtualenv step (success) 21:00:31 INFO - [mozharness: 2016-11-03 04:00:31.296000Z] Running install step. 21:00:31 INFO - Running pre-action listener: _resource_record_pre_action 21:00:31 INFO - Running main action method: install 21:00:31 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 21:00:31 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 21:00:31 INFO - Reading from file tmpfile_stdout 21:00:31 INFO - Using _rmtree_windows ... 21:00:31 INFO - Using _rmtree_windows ... 21:00:31 INFO - Detecting whether we're running mozinstall >=1.0... 21:00:31 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 21:00:31 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 21:00:31 INFO - Reading from file tmpfile_stdout 21:00:31 INFO - Output received: 21:00:31 INFO - Usage: mozinstall-script.py [options] installer 21:00:31 INFO - Options: 21:00:31 INFO - -h, --help show this help message and exit 21:00:31 INFO - -d DEST, --destination=DEST 21:00:31 INFO - Directory to install application into. [default: 21:00:31 INFO - "C:\slave\test"] 21:00:31 INFO - --app=APP Application being installed. [default: firefox] 21:00:31 INFO - Using _rmtree_windows ... 21:00:31 INFO - Using _rmtree_windows ... 21:00:31 INFO - mkdir: C:\slave\test\build\application 21:00:31 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 21:00:31 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-52.0a1.en-US.win64.zip --destination C:\slave\test\build\application ProcessManager NOT managing child processes 21:00:35 INFO - Reading from file tmpfile_stdout 21:00:35 INFO - Output received: 21:00:35 INFO - C:\slave\test\build\application\firefox\firefox.exe 21:00:35 INFO - Using _rmtree_windows ... 21:00:35 INFO - Using _rmtree_windows ... 21:00:35 INFO - Running post-action listener: _resource_record_post_action 21:00:35 INFO - [mozharness: 2016-11-03 04:00:35.376000Z] Finished install step (success) 21:00:35 INFO - [mozharness: 2016-11-03 04:00:35.376000Z] Running run-tests step. 21:00:35 INFO - Running pre-action listener: _resource_record_pre_action 21:00:35 INFO - Running main action method: run_tests 21:00:35 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 21:00:35 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 21:00:35 INFO - Python 2.7.3 21:00:35 INFO - Return code: 0 21:00:35 INFO - grabbing minidump binary from tooltool 21:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:35 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 0x0236AE90>, '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 0x01CFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0280D520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 21:00:35 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 21:00:35 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 21:00:35 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 21:00:35 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 21:00:37 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpvhrzm3 21:00:37 INFO - INFO - File integrity verified, renaming tmpvhrzm3 to win32-minidump_stackwalk.exe 21:00:37 INFO - Return code: 0 21:00:37 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 21:00:37 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 21:00:37 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 21:00:37 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 21:00:37 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 21:00:37 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-032', '--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 21:00:37 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Autoland --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-032 --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 21:00:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 21:00:37 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Roaming', 21:00:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 21:00:37 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 21:00:37 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 21:00:37 INFO - 'COMPUTERNAME': 'T-W864-IX-032', 21:00:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 21:00:37 INFO - 'DCLOCATION': 'SCL3', 21:00:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 21:00:37 INFO - 'FP_NO_HOST_CHECK': 'NO', 21:00:37 INFO - 'HOMEDRIVE': 'C:', 21:00:37 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-032', 21:00:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 21:00:37 INFO - 'KTS_VERSION': '1.19c', 21:00:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-032\\AppData\\Local', 21:00:37 INFO - 'LOGONSERVER': '\\\\T-W864-IX-032', 21:00:37 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 21:00:37 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 21:00:37 INFO - 'MONDIR': 'C:\\Monitor_config\\', 21:00:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 21:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:37 INFO - 'MOZ_NO_REMOTE': '1', 21:00:37 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 21:00:37 INFO - 'NO_EM_RESTART': '1', 21:00:37 INFO - 'NUMBER_OF_PROCESSORS': '8', 21:00:37 INFO - 'OS': 'Windows_NT', 21:00:37 INFO - 'OURDRIVE': 'C:', 21:00:37 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', 21:00:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 21:00:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 21:00:37 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 21:00:37 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 21:00:37 INFO - 'PROCESSOR_LEVEL': '6', 21:00:37 INFO - 'PROCESSOR_REVISION': '1e05', 21:00:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 21:00:37 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 21:00:37 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 21:00:37 INFO - 'PROGRAMW6432': 'C:\\Program Files', 21:00:37 INFO - 'PROMPT': '$P$G', 21:00:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 21:00:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 21:00:37 INFO - 'PUBLIC': 'C:\\Users\\Public', 21:00:37 INFO - 'PWD': 'C:\\slave\\test', 21:00:37 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 21:00:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 21:00:37 INFO - 'SLAVEDIR': 'C:\\slave\\', 21:00:37 INFO - 'SYSTEMDRIVE': 'C:', 21:00:37 INFO - 'SYSTEMROOT': 'C:\\windows', 21:00:37 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:37 INFO - 'TEST1': 'testie', 21:00:37 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 21:00:37 INFO - 'USERDOMAIN': 'T-W864-IX-032', 21:00:37 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-032', 21:00:37 INFO - 'USERNAME': 'cltbld', 21:00:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-032', 21:00:37 INFO - 'WINDIR': 'C:\\windows', 21:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 21:00:37 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-032', '--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 21:00:38 INFO - mozversion application_buildid: 20161102183006 21:00:38 INFO - mozversion application_changeset: 10c5b8d1bef5a8220c13d77127cac8bd1487eb43 21:00:38 INFO - mozversion application_display_name: Nightly 21:00:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:00:38 INFO - mozversion application_name: Firefox 21:00:38 INFO - mozversion application_remotingname: firefox 21:00:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:00:38 INFO - mozversion application_vendor: Mozilla 21:00:38 INFO - mozversion application_version: 52.0a1 21:00:38 INFO - mozversion platform_buildid: 20161102183006 21:00:38 INFO - mozversion platform_changeset: 10c5b8d1bef5a8220c13d77127cac8bd1487eb43 21:00:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:00:38 INFO - mozversion platform_version: 52.0a1 21:00:38 INFO - using testdate: 1478145638 21:00:38 INFO - actual date: 1478145638 21:00:38 INFO - starting webserver on 'localhost:49276' 21:00:38 INFO - SUITE-START | Running 2 tests 21:00:38 INFO - TEST-START | dromaeo_css 21:00:38 INFO - operating with platform_type : w8_ 21:00:38 INFO - Initialising browser for dromaeo_css test... 21:00:38 INFO - TEST-INFO | started process 1532 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdi05lu\profile http://localhost:49276/getInfo.html) 21:00:46 INFO - PROCESS | 1532 | __metrics Screen width/height:1600/1200 21:00:46 INFO - PROCESS | 1532 | colorDepth:24 21:00:46 INFO - PROCESS | 1532 | Browser inner width/height: 1010/674 21:00:46 INFO - PROCESS | 1532 | __metrics 21:00:47 INFO - PROCESS | 1532 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:00:47 INFO - PROCESS | 1532 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:00:48 INFO - TEST-INFO | 1532: exit 0 21:00:48 INFO - Browser initialized. 21:00:48 INFO - Running cycle 1/1 for dromaeo_css test... 21:00:48 INFO - TEST-INFO | started process 620 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdi05lu\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:00:49 INFO - PROCESS | 620 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 21:01:00 INFO - PROCESS | 620 | RSS: Main: 160268288 21:01:00 INFO - PROCESS | 620 | 21:01:50 INFO - PROCESS | 620 | 1478145710701 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] 21:04:02 INFO - PROCESS | 620 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 21:04:04 INFO - PROCESS | 620 | RSS: Main: 238755840 21:04:04 INFO - PROCESS | 620 | 21:07:07 INFO - PROCESS | 620 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 21:07:07 INFO - PROCESS | 620 | RSS: Main: 230256640 21:07:07 INFO - PROCESS | 620 | 21:10:10 INFO - PROCESS | 620 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 21:10:10 INFO - PROCESS | 620 | RSS: Main: 208859136 21:10:10 INFO - PROCESS | 620 | 21:13:12 INFO - PROCESS | 620 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 21:13:13 INFO - PROCESS | 620 | RSS: Main: 174223360 21:13:13 INFO - PROCESS | 620 | 21:16:16 INFO - PROCESS | 620 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 21:16:16 INFO - PROCESS | 620 | RSS: Main: 165224448 21:16:16 INFO - PROCESS | 620 | 21:19:19 INFO - PROCESS | 620 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 21:19:19 INFO - PROCESS | 620 | RSS: Main: 212074496 21:19:19 INFO - PROCESS | 620 | 21:19:19 INFO - PROCESS | 620 | __start_tp_report 21:19:19 INFO - PROCESS | 620 | _x_x_mozilla_page_load 21:19:19 INFO - PROCESS | 620 | _x_x_mozilla_page_load_details 21:19:19 INFO - PROCESS | 620 | |i|pagename|runs| 21:19:19 INFO - PROCESS | 620 | |0;dojo.html;2848.4587928293627;2883.106237066508;2910.6652734935487;2916.110586271188;2929.1066224801425;5098.133317336053;5210.062188806013;5214.556762675177;5242.947570524294;5263.131583288753;5021.221710634848;5139.588832893369;5157.020166168425;5157.948420515794;5169.121249387604;4663.720176789387;4686.507916668752;4687.6952998055185;4716.080364328957;4748.35897153885;4707.646926480511;4748.145333839908;4758.952410475886;4761.642876784255;4771.212749896263;4664.090502352043;4716.669833111683;4747.074320507485;4753.928691069636;4763.76181190939;4670.743109128996;4743.573078422958;4759.000609871931;4773.403324584427;4825.565699087099;4575.588197062247;4607.055553611502;4677.953220467786;4711.599514041311;4740.383750112498;5205.947940520584;5228.764705588258;5236.633435659505;5251;5264.131418315973;5522.502974732293;5540.972295138498;5549.916751248735;5581.972090139564;5599.160125981135;5597.216389705444;5623.0159722048475;5658.632188907708;5674.347450043216;5676.375598684142;5029.647924645313;5097.923531147036;5155.871103222375;5211.166213405837;5272.894542109137;5761.337446193657;5763.106718458645;5777.653340799566;5785.132230165509;5855.238818953509;5483.067878460672;5495.2856128703015;5502.58730595207;5507.421720719347;5508.14623733322;5488.91766623501;5532.5020748132865;5533.778648854081;5617.354004289477;5619.100943849046;5459.508644222039;5505.476979686923;5516.779328826882;5520.806771762969;5584.86037849057;5474;5476.397596264408;5480.91778623321;5488.204210389471;5553.139263414178;3702.72229582777;3769.6607305342104;3786.678132358725;3794.5067141271456;3836.271108489378;3264.135004223883;3279.6720327967014;3303.6200836904063;3310.851011704479;3326;5174.223866419992;5182.119039763249;5182.818601348935;5208.8958220835375;5214.191800270888;5541.27963364768;5568.832935011957;5570.498655121059;5586.050371436784;5609.467100625434;5167.405748338914;5177.559907407837;5181.53366197044;5192.1952097424955;5204.9219261711105;4505.662075344362;4522.253828118323;4527.864164075083;4530.026044400403;4533.093381323749;5647.661140331511;5724.8282551523525;5730.398308177665;5732.684702341411;5735.254416925773;5581.860453488533;5585.776568937197;5597.3003374578175;5629.8592535186945;5647.3505546861;5729.570282228766;5730.598858079894;5734.168545560954;5746.856328591819;5749.453801888814;5379.273798037371;5467.234587157881;5490.725463726878;5510.6969116698965;5523.502884740393;5481.205225242397;5549.417311182429;5552.888942221052;5558.944410556004;5559.277293951922;5296.841094767163;5339.7063161526485;5348.839534813962;5353.678779273256;5355.651882627617;5322.175062865262;5331.813386531453;5348.358197016383;5356.1697936819855;5423.891522169455;5272.578193744414;5331.09371406854;5364.088105022233;5412.269343638716;5412.296401467784;5477.287952566141;5588.720563971867;5596.720163991703;5601.691906945157;5610.691411972218;5358.732063396893;5454.863628409163;5455.563554915677;5458.61789674719;5462.562994960473 21:19:19 INFO - PROCESS | 620 | |1;ext.html;548.4542879834563;552.304096837984;564.7119968815903;565.4204440448541;568.4912003756635;28297.292567685792;37510;38968.610313896854;39127.41308880369;41470.58529414705;38699.613003869956;38887.61112388875;39116.80441597795;39254.21491570167;39356.212875742465;8354.874676879852;8457.492550446992;8487.95756021219;8490.830183396329;8501.744947651581;7391.815204619874;7577.659005344745;7585.7344992925255;7713.382929365665;7727.343175830033;9915.752106197368;10137.847932281022;10178.491075446198;10390.376577405343;10449.582016719321;10019.44893030883;10093.444860532667;10100.292979491438;10107.494625268744;10123.949380253125;7529.397648188186;7743.961280193619;9568.521573921276;9921.851172232422;10017.298789084767;34324.82837585821;37721.43417848707;37764;37785.43321850174;37833;2683.610876422927;2705.878235479408;2821.2946763309174;3344.832758362072;3572.321258960815;28035.85982070097;29104.272393190127;29427.705722942712;30057.849710751525;30624.693753062405;4034.515858097018;4057.6753859691153;4092.774897380643;4115.279826030463;4172.290710579209;312554;315063;315423.99999999773;316569;317265;49674;49806;49842.50157498451;50131.24803127956;50225;44560.77719611381;44731.329030064575;44828.53443060663;44922.550774491836;45029;13134.211947283002;13390.062695611408;13428.462861485626;13461.932690336682;13518;10396.948015259875;10401.58393664245;10410.843837342445;10413.47932603382;10474.47627618616;12739.363031848556;13585.456581736818;15658.530244092695;15894.443694470869;16040.919795400949;6091.111755355854;6140.263168419819;6150.630962142286;6179.536534759821;6218;662.5858838226109;680.8774420604339;726.9963650181716;803.9035315762029;821.9712310069239;25247.747522524907;25310.36724081876;25592.616110758354;25864;25912.870435648078;800.4596897094555;807.0597753617088;812.6505602590825;828.1387357148618;847.9957600211959;13390.26353550564;13460.93269533646;13721.10812797185;13787.724245515034;13793.172409655454;511666;512429;515951;516933;519095;48861.26708099381;49260.26109608359;49354.50645493499;49417;49417;861.5390765940317;955.1928620315822;959.4435227567993;1029.2897900448665;1048.260976011925;27127.321816954733;28306.85846570754;28394.43211135807;28520;29004.12987610375;42414;42815.571844281156;43087.56912430836;43110;43122.78438607787;328840;366514.16742916114;370470;371227;372303;21932.780672193076;22587.66118508191;22594.66108008414;23616;23715.762842371354;40908.59091409167;41188.38217426681;41333.79333103315;41425;41893.79053104715;31362.21594460157;31680.841595791873;31800.204994875312;31992.360152796347;32141.35717285688;34649;35263;35346.11634709153;35813.46279805753;36058;33924.83037584796;34368.48447273343;34450.48324275088;34640;34980.47529287012;28320.71679283181;28590.142295731162;31039.224019399695;31284.843575782885;31353.37293254168;21875.781242187375;21908.45228869291;21995.670064948717;22024;22025.889870550545 21:19:20 INFO - PROCESS | 620 | |2;jquery.html;317.9427703013457;323.1275555998804;327.0922081618673;327.7476343215723;335.42307231561705;12977.48090076397;13923.582292531228;17056.744148837777;17627;17840;16092.75860862088;16298;16591.253393597286;16667.66664666709;16915.83084169161;3959.732885476649;5217.217417387385;5379.9731001345135;5420.1327787554;5422.48486393792;5190.351206099238;5302;5308.336457942757;5310.230016647583;5315.867103322409;5045.217991211368;5244.187150991603;5268.6575372600655;5271.578273738091;5280;5226.189940559219;5240.52835244826;5249.790008399659;5260.105782017066;5270.472952704718;4507.797149128297;4540.545945405433;4585.174668559658;4698.600618947394;4719.834805781816;20198.869175277854;20360.389188324374;20427.387178384673;20550.07524661394;20706.792932070788;1740.3995621510558;1774.370098614986;1778.5731424458165;1897.7817550981677;2625.687156421789;12952.676183095404;13078.476860925552;13112.082154249207;13213.669658258525;13667.726645467135;1687.6540309236577;1722.4057700093447;1723.388197189992;1737.9391721289821;1756.2448147296657;64220.036699450015;64267;64324.3567564323;64430;65169;8422.157784221652;8422.915770842335;8456.06983231844;8822.470651760916;8912.108789121166;11668.183227174186;11789.174757766874;11789.233699809485;11806.350650714294;11874.584389546324;6790.11728475305;6969.909027291792;6975.51171418006;7058.788236352918;7072.222055573883;6940.09778728762;6940.410065144419;7057.258987806309;7063.752768653175;7069.081019467436;5519.613627046068;5578.470045345685;5581.302337207849;5588.832335029955;5673.290838645169;1554.4481708993144;1568.0513289459714;1568.5451219146319;1629.2016911713174;1666.30015393535;628.4187126907592;658.1312667279145;676.9120014398195;742.7920182348951;773.4044785515234;15872.127033013296;15921.283542240628;16013.359465621244;16268.26792794327;16517.752233716503;715.7530651925077;737.7049180327805;742.0538813013451;786.8622990976556;814.8411059843393;8651.653933842701;9011.504367259864;9055.18503334703;9098.135677110664;9165.81668366629;378612.1069394635;425591;429280;433524;436199;51692.74153629208;79053.2568045919;81272;81833;83699.16300837035;854.5812551849549;860.6600392844916;863.8661007543841;884.7522693645661;886.4636894678627;14823.555293341216;15256.923715381352;15333.310001049756;15506.612334691723;15684.607884802972;33751;33982;34000.65999339975;34032.829835850665;35038.64961350456;47008;47303.763481182374;47686;48309.75845120752;48478.757606211744;6777.6272305023695;6783.321667833177;6840.144981877265;6863.553868998499;7077.823054423475;8679.435836670596;10843;11118.388488633203;11172.720681983015;11214;8880.77798055028;9151.496667683341;9188.632454701738;9681.70954871355;9808.117269445784;8943.150400711922;8983.775405614912;9327.673531426368;9485.810283794148;9526.904730952601;9590.856137157809;10053.018454019846;10060.245481589056;10217.795644087226;10590.258681892194;6030.4572588467245;6676.599404035774;6697.799066028027;6757;6819.659017049028;7714.305712485903;9283.72148835536;9512.95243523778;9644.228461723185;9656.75858103553 21:19:20 INFO - PROCESS | 620 | |3;mootools.html;1097.5445190246048;1172.4782471800047;1174.9295042297463;1248.4943597842873;1442.0266320233845;6483.870322593545;6968.581885086892;7217.422606191505;7237.674304656283;7240.456965727578;7089.361957423831;7367.300106489874;7377.151627562832;7389.261073892621;7413.332800047994;1925.9422217333502;1954.8338391236762;1958.6866101423775;1959.882407055574;1967.9901600491978;1909.8281154696074;1912.9139188736472;1914.626647803679;1970.0543739005286;1985.0471773548704;1903.8476921846288;1917.731517587539;1918.9158125659028;1921.5580416504213;1931.2178567680112;1864.0679660169915;1897.943061708151;1902.9714554281697;1903.3338331583973;1903.8476921846288;1867.9066046697747;1872.8876267423861;1889.4426144287468;1896.6586014517381;1904.1716853168916;7033;7084.14990201174;7095.680694368766;7133.393661538776;7161.069061022086;4319.114581510783;4429.800658970354;4433.9801845575375;4495.57292057254;4498.280275155959;2792.6788419331833;3027.7880548361622;3072.646645635758;3086.4444400007987;3086.4907290297074;874.3224001398903;884.195382202193;891.5720454181965;968.7142293023575;969.7090872738221;9632.325737198398;9694.079062489052;9814.263930205192;9827.90172098277;9850.50747462624;3781.810909454516;3836.5971572984995;3859.286032084073;3937.9803100984886;3946.210757848442;7755.302022817974;7781.182975787574;7872.291493765589;7873.409494287836;7898.644560994769;4446.666500012512;4448.332750087448;4448.466184057934;4459.821607135678;4462.709923854939;3573.3746594345885;3612.205314830733;4175.081482073939;4181.1428657125825;4187.288161012574;3231.644519102897;3296.3407318536388;3320.6181289151573;3327.234736010731;3353.4634458486526;966.9661561845302;991.4101109839634;992.4442312304988;995.7261753017978;1004.5931397783909;502.41719605257725;635.4249404289126;696.3767428151775;700.9859802803916;705.0270626535348;4027.3153563894207;4080.2458340619964;4148.128892932457;4186.246475634415;4244.087521182899;647.2782847125516;660.389140045456;661.1339145719123;682.1200651160048;682.9556078854858;2640.6435131257417;2864.255293623673;2890.638670166229;3073.0473553198135;3201.919952001172;8693.913060869438;8740.781480462912;8857.557122143997;8864.113588641085;8870.246029087471;8714.302855771522;8849.247813935759;8849.292056635453;8861.892263467067;8872.556372181365;6548.738050477928;6729.125213722283;6754.493412994045;6870.416014638712;6875.346842049998;4239.236937351183;4267.125239325868;4315.115401342655;4325;4533.6373090153365;7749.651265692944;7897.24976127267;8215.342772578299;8221.342292616457;8265.132161123236;7981.8802717958115;8169.591520424074;8193.426460147732;8206.548639824867;8229.835403291781;6396.776112836028;6494.772682956074;6524.67376631176;6539.607623542603;6562.081308616893;6713.798586042427;6759.324067593201;6811.046453496416;7049.48436086244;7052.717891284291;6209.348018457997;6210.472109870531;6257.749690012531;6345.46063584582;6431.517636177212;6070.575059745775;6147.631142131487;6171.352008039091;6189.102580125947;6219.471344935731;5382.246485492113;5469.097598896296;5591.133374326986;5605.215269862304;5640.943590564206;3488.337215928965;3588.102974256436;3594.4788005739542;3613.855445782139;3665.890023299305;3745.6441638044344;3747.1756213632957;3755.7183211258716;3831.3869780834934;3870.8258128383727 21:19:20 INFO - PROCESS | 620 | |4;prototype.html;280.3663719992816;282.75117896251294;285.5944558726607;289.44279774811525;290.59026772251104;5097.974510127448;5133.409657889344;5147.9227811582805;5157.638965272437;5181.6113791465605;5051.343325367706;5070.67040642358;5089.923651145235;5130.563902068328;5196.220566914964;3705.2033812730324;3830.4828848105567;3853;3855.363864962278;3858.305505009097;3805.7145714071416;3819.618038196172;3838.865639702611;3887.611238876118;3913.4129880518008;3828.923421531568;3830.8276127574186;3859.1316953685478;3860.5946375630574;3909.2213043065335;3806.200697853454;3837.884863454087;3847.057470919615;3858.189780146173;3879.1465877507044;3354.798712077283;3368.2758206985372;3370.882019129319;3379.256563556038;3412.9658703413143;4952.975235123838;4959.156943319645;4987.925181122286;4990.5508504234795;4995.325631039799;4385.6710746694125;4508.909821803579;4537.137943790669;4541.568550987651;4544.136614043321;5291.550218231455;5300.178472336794;5303.761330740087;5323.083689871682;5332.546733527654;3715.9628403715888;3716.8327425265657;3750.4374343848367;3752.1182522107283;3757;5667.149927510865;5674.546036317085;5680.3018566181145;5689;5704.4295570443455;3547.3082748863726;3717.5910649828497;3726.4782930389765;3739.476473293741;3748.4002559590335;3811.1805961718364;3813.256414999104;3813.8474461021246;3818.16000479894;3819.7845249755073;4425.96821177488;4449.644028477714;4455.643548516111;4484.439445069366;4489.595936365743;5212.7914883405;5315.867103322371;5327.254184414185;5397.541208997279;5456.536194423518;1298.2470167302943;1316.0721691207866;1316.960491185266;1322.6032190342858;1323.8146659467682;798.5568009754642;812.4312980913385;818.2186012358184;829.4898637337993;832.8839355263975;4970.676906001098;5089.345962562182;5120.283160357553;5220.791168353299;5235.3717553893775;5550;5553.0004599172535;5555.972220138873;5605.299337582802;5629.4652008059165;5053.179553920026;5160.458151893997;5166.5866730661455;5180.818671346485;5254.579633629301;2925.6489221293155;2939.8236105833716;2953.9113826585235;2961.1412690319567;2970.569267456207;5598.58010649203;5610.49505544503;5646.096624540054;5649.627156594241;5666.15007748841;5490.121580547093;5615.971920140373;5646.378898321182;5649.915251271234;5708.802111187223;5614.354349249807;5621.887562248732;5658.377578466366;5679.318481782213;5686.374498805046;5245.606579506629;5498.395176530498;5522.22688823573;5525.198846167364;5563.246193134424;5391.460853914734;5394.649347792381;5407.756650950638;5454.509094181542;5457;5581.162825576196;5603.80386686464;5605.5515558756015;5622.690752008679;5624.931263060005;3547.733919956065;3703.055720791181;3727.5713292971654;3732.682721968663;3746;5517.944820551904;5532.474414930575;5538.141588053858;5554.250176226319;5572.498475137257;5383.865403364947;5388.595855310946;5395.244665746877;5396.83809485716;5411.70235637028;5274.261603375608;5277.812492189227;5375.220593014069;5393.43368946255;5398.730063496888;5317.25558421829;5320.840374788762;5324.627276090637;5344.438833922382;5351.351081214823;5204.423810213968;5344.503539009083;5349.101069120562;5410.674384775755;5477.041517734301;5402.486763757437;5404.2163886235485;5406.567474602101;5411.458854114557;5419.701916394636 21:19:20 INFO - PROCESS | 620 | |5;yui.html;544.722191682242;585.467224825409;598.6946657204829;633.6831584207896;642.5373730913743;12828.67928301793;13860.306984650751;13883.236421996786;13910.304484775746;13918.44326226951;11915.821262681045;12651.304178270191;12652.114351995364;12681.30252836096;12689.809652855192;506.68079110160545;524.5672320335719;621.0373920423349;638.4381744065216;641.4131070070903;532.7176596403912;533.970631615261;540.8377486753977;619.2414292491707;635.3043417457876;670.5172275961324;678.3758941773556;679.0696745458729;679.1680191765098;679.4937771360344;668.1981622053531;672.062472850371;672.132948496439;675.7398401615388;676.1041619853713;395.01837932737124;401.94171845082593;472.45667482395174;491.90407870465276;496.18130085359087;12237.755244895141;12882.355882205853;12896.161749486253;12902.225866448043;12915.418806153652;11880.227785193934;12036.277823330629;12124.939375303067;12260.203086799329;12352.197107188094;10908.672739817817;10935.179861510418;10952.616658416917;11016.339019658766;11170.609028683957;4086.9591304086875;4103.97948010258;4111.650509706648;4115.8971025724295;4228.175505776375;51001.23498147494;52442.47557524452;59027.409725902624;59614;59650.10524842131;8692.348073894356;8716.694915677921;8785.34109941757;8957.865632015524;9009.729708108767;15626.140562269184;15830.9208453957;15834.366625335088;15849.286782094834;15907.965982211119;7086.751963681247;7105.360517553341;7303.926960730325;7398.741044063432;7415.40676745859;4136.172765446922;4183.790810459464;4248.91502169961;4264.637505811978;4345.760983145894;2804.78964077695;2860.3707184419395;2862.4418238443304;2902.274431392152;2912.359280958186;512.554077952184;519.7349351830594;521.116707181324;527.1591811061351;536.6914024435965;574.4427904932209;585.6749504025307;589.1516216648013;609.1076572820839;622.0513716582249;9133.223675987483;9215.308851836138;9244.352895297265;9434.386764860263;9504.477253750973;556.9693666848282;564.51169738177;591.482452853753;619.8388419011089;621.4189732600033;4013.678905687538;4046.635802777764;4095.3037983542868;4142.2543942090115;4201.411802347674;51369;58735;63813.36186638167;68835.65582172057;69290.65354673195;48608;59847.700761495915;60203;60796.696016519636;60998.39001609927;54284;55218.44781552214;55648.44351556514;56786.71606642023;57047.42952570504;8392.244697977212;8499.74500764978;8512.98840223499;8514.978202615726;8727.781805454915;36093.819530902176;36393.27213455663;37190.25619487541;37316;38212.23575528529;45477.54522454733;45853.082938340376;50407.49592504028;51223.74388128035;51651.74174129105;10011.099001089937;10235.795284094127;10422.276743861292;10577.735556611146;10799.946000269949;11954.880451195377;12017.939910300393;12085.637430877088;12312.445939932904;12458.813117803422;11975.940120299343;12046.578369757017;12164.574239901562;12296.385180740748;12465.5013799447;11269.323840569592;11357.318560886373;11448.542058317575;11889.762204756029;12426.192297500633;12037.879621203676;12171.391430428266;12219.938900305442;12261.26432414058;12272.263664180178;10277.378935497054;10546.947265263625;10684.62603808894;11106.777864442827;11130.387828669502;10589.364638121737;10613.946930265609;10680.679579612313;10691.57233710674;10902 21:19:20 INFO - PROCESS | 620 | __end_tp_report 21:19:20 INFO - PROCESS | 620 | __start_cc_report 21:19:20 INFO - PROCESS | 620 | _x_x_mozilla_cycle_collect,1632 21:19:20 INFO - PROCESS | 620 | __end_cc_report 21:19:20 INFO - PROCESS | 620 | __startTimestamp1478146759981__endTimestamp 21:19:20 INFO - PROCESS | 620 | 21:19:20 INFO - PROCESS | 620 | ------- Summary: start ------- 21:19:20 INFO - PROCESS | 620 | Number of tests: 6 21:19:20 INFO - PROCESS | 620 | 21:19:20 INFO - PROCESS | 620 | [#0] dojo.html Cycles:165 Average:5120.47 Median:5348.84 stddev:672.01 (12.6%) stddev-sans-first:650.00 21:19:20 INFO - PROCESS | 620 | Values: 2848.5 2883.1 2910.7 2916.1 2929.1 5098.1 5210.1 5214.6 5242.9 5263.1 5021.2 5139.6 5157.0 5157.9 5169.1 4663.7 4686.5 4687.7 4716.1 4748.4 4707.6 4748.1 4759.0 4761.6 4771.2 4664.1 4716.7 4747.1 4753.9 4763.8 4670.7 4743.6 4759.0 4773.4 4825.6 4575.6 4607.1 4678.0 4711.6 4740.4 5205.9 5228.8 5236.6 5251.0 5264.1 5522.5 5541.0 5549.9 5582.0 5599.2 5597.2 5623.0 5658.6 5674.3 5676.4 5029.6 5097.9 5155.9 5211.2 5272.9 5761.3 5763.1 5777.7 5785.1 5855.2 5483.1 5495.3 5502.6 5507.4 5508.1 5488.9 5532.5 5533.8 5617.4 5619.1 5459.5 5505.5 5516.8 5520.8 5584.9 5474.0 5476.4 5480.9 5488.2 5553.1 3702.7 3769.7 3786.7 3794.5 3836.3 3264.1 3279.7 3303.6 3310.9 3326.0 5174.2 5182.1 5182.8 5208.9 5214.2 5541.3 5568.8 5570.5 5586.1 5609.5 5167.4 5177.6 5181.5 5192.2 5204.9 4505.7 4522.3 4527.9 4530.0 4533.1 5647.7 5724.8 5730.4 5732.7 5735.3 5581.9 5585.8 5597.3 5629.9 5647.4 5729.6 5730.6 5734.2 5746.9 5749.5 5379.3 5467.2 5490.7 5510.7 5523.5 5481.2 5549.4 5552.9 5558.9 5559.3 5296.8 5339.7 5348.8 5353.7 5355.7 5322.2 5331.8 5348.4 5356.2 5423.9 5272.6 5331.1 5364.1 5412.3 5412.3 5477.3 5588.7 5596.7 5601.7 5610.7 5358.7 5454.9 5455.6 5458.6 5462.6 21:19:20 INFO - PROCESS | 620 | 21:19:20 INFO - PROCESS | 620 | [#1] ext.html Cycles:180 Average:52995.34 Median:368492.08 stddev:108144.31 (29.3%) stddev-sans-first:108375.99 21:19:20 INFO - PROCESS | 620 | Values: 548.5 552.3 564.7 565.4 568.5 28297.3 37510.0 38968.6 39127.4 41470.6 38699.6 38887.6 39116.8 39254.2 39356.2 8354.9 8457.5 8488.0 8490.8 8501.7 7391.8 7577.7 7585.7 7713.4 7727.3 9915.8 10137.8 10178.5 10390.4 10449.6 10019.4 10093.4 10100.3 10107.5 10123.9 7529.4 7744.0 9568.5 9921.9 10017.3 34324.8 37721.4 37764.0 37785.4 37833.0 2683.6 2705.9 2821.3 3344.8 3572.3 28035.9 29104.3 29427.7 30057.8 30624.7 4034.5 4057.7 4092.8 4115.3 4172.3 312554.0 315063.0 315424.0 316569.0 317265.0 49674.0 49806.0 49842.5 50131.2 50225.0 44560.8 44731.3 44828.5 44922.6 45029.0 13134.2 13390.1 13428.5 13461.9 13518.0 10396.9 10401.6 10410.8 10413.5 10474.5 12739.4 13585.5 15658.5 15894.4 16040.9 6091.1 6140.3 6150.6 6179.5 6218.0 662.6 680.9 727.0 803.9 822.0 25247.7 25310.4 25592.6 25864.0 25912.9 800.5 807.1 812.7 828.1 848.0 13390.3 13460.9 13721.1 13787.7 13793.2 511666.0 512429.0 515951.0 516933.0 519095.0 48861.3 49260.3 49354.5 49417.0 49417.0 861.5 955.2 959.4 1029.3 1048.3 27127.3 28306.9 28394.4 28520.0 29004.1 42414.0 42815.6 43087.6 43110.0 43122.8 328840.0 366514.2 370470.0 371227.0 372303.0 21932.8 22587.7 22594.7 23616.0 23715.8 40908.6 41188.4 41333.8 41425.0 41893.8 31362.2 31680.8 31800.2 31992.4 32141.4 34649.0 35263.0 35346.1 35813.5 36058.0 33924.8 34368.5 34450.5 34640.0 34980.5 28320.7 28590.1 31039.2 31284.8 31353.4 21875.8 21908.5 21995.7 22024.0 22025.9 21:19:20 INFO - PROCESS | 620 | 21:19:20 INFO - PROCESS | 620 | [#2] jquery.html Cycles:180 Average:24564.54 Median:5246.99 stddev:69287.67 (1320.5%) stddev-sans-first:69458.12 21:19:20 INFO - PROCESS | 620 | Values: 317.9 323.1 327.1 327.7 335.4 12977.5 13923.6 17056.7 17627.0 17840.0 16092.8 16298.0 16591.3 16667.7 16915.8 3959.7 5217.2 5380.0 5420.1 5422.5 5190.4 5302.0 5308.3 5310.2 5315.9 5045.2 5244.2 5268.7 5271.6 5280.0 5226.2 5240.5 5249.8 5260.1 5270.5 4507.8 4540.5 4585.2 4698.6 4719.8 20198.9 20360.4 20427.4 20550.1 20706.8 1740.4 1774.4 1778.6 1897.8 2625.7 12952.7 13078.5 13112.1 13213.7 13667.7 1687.7 1722.4 1723.4 1737.9 1756.2 64220.0 64267.0 64324.4 64430.0 65169.0 8422.2 8422.9 8456.1 8822.5 8912.1 11668.2 11789.2 11789.2 11806.4 11874.6 6790.1 6969.9 6975.5 7058.8 7072.2 6940.1 6940.4 7057.3 7063.8 7069.1 5519.6 5578.5 5581.3 5588.8 5673.3 1554.4 1568.1 1568.5 1629.2 1666.3 628.4 658.1 676.9 742.8 773.4 15872.1 15921.3 16013.4 16268.3 16517.8 715.8 737.7 742.1 786.9 814.8 8651.7 9011.5 9055.2 9098.1 9165.8 378612.1 425591.0 429280.0 433524.0 436199.0 51692.7 79053.3 81272.0 81833.0 83699.2 854.6 860.7 863.9 884.8 886.5 14823.6 15256.9 15333.3 15506.6 15684.6 33751.0 33982.0 34000.7 34032.8 35038.6 47008.0 47303.8 47686.0 48309.8 48478.8 6777.6 6783.3 6840.1 6863.6 7077.8 8679.4 10843.0 11118.4 11172.7 11214.0 8880.8 9151.5 9188.6 9681.7 9808.1 8943.2 8983.8 9327.7 9485.8 9526.9 9590.9 10053.0 10060.2 10217.8 10590.3 6030.5 6676.6 6697.8 6757.0 6819.7 7714.3 9283.7 9513.0 9644.2 9656.8 21:19:20 INFO - PROCESS | 620 | 21:19:20 INFO - PROCESS | 620 | [#3] mootools.html Cycles:180 Average:4636.07 Median:5623.08 stddev:2652.84 (47.2%) stddev-sans-first:2646.95 21:19:20 INFO - PROCESS | 620 | Values: 1097.5 1172.5 1174.9 1248.5 1442.0 6483.9 6968.6 7217.4 7237.7 7240.5 7089.4 7367.3 7377.2 7389.3 7413.3 1925.9 1954.8 1958.7 1959.9 1968.0 1909.8 1912.9 1914.6 1970.1 1985.0 1903.8 1917.7 1918.9 1921.6 1931.2 1864.1 1897.9 1903.0 1903.3 1903.8 1867.9 1872.9 1889.4 1896.7 1904.2 7033.0 7084.1 7095.7 7133.4 7161.1 4319.1 4429.8 4434.0 4495.6 4498.3 2792.7 3027.8 3072.6 3086.4 3086.5 874.3 884.2 891.6 968.7 969.7 9632.3 9694.1 9814.3 9827.9 9850.5 3781.8 3836.6 3859.3 3938.0 3946.2 7755.3 7781.2 7872.3 7873.4 7898.6 4446.7 4448.3 4448.5 4459.8 4462.7 3573.4 3612.2 4175.1 4181.1 4187.3 3231.6 3296.3 3320.6 3327.2 3353.5 967.0 991.4 992.4 995.7 1004.6 502.4 635.4 696.4 701.0 705.0 4027.3 4080.2 4148.1 4186.2 4244.1 647.3 660.4 661.1 682.1 683.0 2640.6 2864.3 2890.6 3073.0 3201.9 8693.9 8740.8 8857.6 8864.1 8870.2 8714.3 8849.2 8849.3 8861.9 8872.6 6548.7 6729.1 6754.5 6870.4 6875.3 4239.2 4267.1 4315.1 4325.0 4533.6 7749.7 7897.2 8215.3 8221.3 8265.1 7981.9 8169.6 8193.4 8206.5 8229.8 6396.8 6494.8 6524.7 6539.6 6562.1 6713.8 6759.3 6811.0 7049.5 7052.7 6209.3 6210.5 6257.7 6345.5 6431.5 6070.6 6147.6 6171.4 6189.1 6219.5 5382.2 5469.1 5591.1 5605.2 5640.9 3488.3 3588.1 3594.5 3613.9 3665.9 3745.6 3747.2 3755.7 3831.4 3870.8 21:19:20 INFO - PROCESS | 620 | 21:19:20 INFO - PROCESS | 620 | [#4] prototype.html Cycles:180 Average:4479.19 Median:5188.92 stddev:1365.72 (26.3%) stddev-sans-first:1332.69 21:19:20 INFO - PROCESS | 620 | Values: 280.4 282.8 285.6 289.4 290.6 5098.0 5133.4 5147.9 5157.6 5181.6 5051.3 5070.7 5089.9 5130.6 5196.2 3705.2 3830.5 3853.0 3855.4 3858.3 3805.7 3819.6 3838.9 3887.6 3913.4 3828.9 3830.8 3859.1 3860.6 3909.2 3806.2 3837.9 3847.1 3858.2 3879.1 3354.8 3368.3 3370.9 3379.3 3413.0 4953.0 4959.2 4987.9 4990.6 4995.3 4385.7 4508.9 4537.1 4541.6 4544.1 5291.6 5300.2 5303.8 5323.1 5332.5 3716.0 3716.8 3750.4 3752.1 3757.0 5667.1 5674.5 5680.3 5689.0 5704.4 3547.3 3717.6 3726.5 3739.5 3748.4 3811.2 3813.3 3813.8 3818.2 3819.8 4426.0 4449.6 4455.6 4484.4 4489.6 5212.8 5315.9 5327.3 5397.5 5456.5 1298.2 1316.1 1317.0 1322.6 1323.8 798.6 812.4 818.2 829.5 832.9 4970.7 5089.3 5120.3 5220.8 5235.4 5550.0 5553.0 5556.0 5605.3 5629.5 5053.2 5160.5 5166.6 5180.8 5254.6 2925.6 2939.8 2953.9 2961.1 2970.6 5598.6 5610.5 5646.1 5649.6 5666.2 5490.1 5616.0 5646.4 5649.9 5708.8 5614.4 5621.9 5658.4 5679.3 5686.4 5245.6 5498.4 5522.2 5525.2 5563.2 5391.5 5394.6 5407.8 5454.5 5457.0 5581.2 5603.8 5605.6 5622.7 5624.9 3547.7 3703.1 3727.6 3732.7 3746.0 5517.9 5532.5 5538.1 5554.3 5572.5 5383.9 5388.6 5395.2 5396.8 5411.7 5274.3 5277.8 5375.2 5393.4 5398.7 5317.3 5320.8 5324.6 5344.4 5351.4 5204.4 5344.5 5349.1 5410.7 5477.0 5402.5 5404.2 5406.6 5411.5 5419.7 21:19:20 INFO - PROCESS | 620 | 21:19:20 INFO - PROCESS | 620 | [#5] yui.html Cycles:180 Average:14753.50 Median:4305.20 stddev:18214.59 (423.1%) stddev-sans-first:18234.43 21:19:20 INFO - PROCESS | 620 | Values: 544.7 585.5 598.7 633.7 642.5 12828.7 13860.3 13883.2 13910.3 13918.4 11915.8 12651.3 12652.1 12681.3 12689.8 506.7 524.6 621.0 638.4 641.4 532.7 534.0 540.8 619.2 635.3 670.5 678.4 679.1 679.2 679.5 668.2 672.1 672.1 675.7 676.1 395.0 401.9 472.5 491.9 496.2 12237.8 12882.4 12896.2 12902.2 12915.4 11880.2 12036.3 12124.9 12260.2 12352.2 10908.7 10935.2 10952.6 11016.3 11170.6 4087.0 4104.0 4111.7 4115.9 4228.2 51001.2 52442.5 59027.4 59614.0 59650.1 8692.3 8716.7 8785.3 8957.9 9009.7 15626.1 15830.9 15834.4 15849.3 15908.0 7086.8 7105.4 7303.9 7398.7 7415.4 4136.2 4183.8 4248.9 4264.6 4345.8 2804.8 2860.4 2862.4 2902.3 2912.4 512.6 519.7 521.1 527.2 536.7 574.4 585.7 589.2 609.1 622.1 9133.2 9215.3 9244.4 9434.4 9504.5 557.0 564.5 591.5 619.8 621.4 4013.7 4046.6 4095.3 4142.3 4201.4 51369.0 58735.0 63813.4 68835.7 69290.7 48608.0 59847.7 60203.0 60796.7 60998.4 54284.0 55218.4 55648.4 56786.7 57047.4 8392.2 8499.7 8513.0 8515.0 8727.8 36093.8 36393.3 37190.3 37316.0 38212.2 45477.5 45853.1 50407.5 51223.7 51651.7 10011.1 10235.8 10422.3 10577.7 10799.9 11954.9 12017.9 12085.6 12312.4 12458.8 11975.9 12046.6 12164.6 12296.4 12465.5 11269.3 11357.3 11448.5 11889.8 12426.2 12037.9 12171.4 12219.9 12261.3 12272.3 10277.4 10546.9 10684.6 11106.8 11130.4 10589.4 10613.9 10680.7 10691.6 10902.0 21:19:20 INFO - PROCESS | 620 | -------- Summary: end -------- 21:19:20 INFO - PROCESS | 620 | 21:19:20 INFO - TEST-INFO | 620: exit 0 21:19:21 INFO - TEST-OK | dromaeo_css | took 1123247ms 21:19:21 INFO - TEST-START | kraken 21:19:21 INFO - operating with platform_type : w8_ 21:19:21 INFO - Initialising browser for kraken test... 21:19:21 INFO - TEST-INFO | started process 2912 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpoiqk1n\profile http://localhost:49276/getInfo.html) 21:19:26 INFO - PROCESS | 2912 | __metrics Screen width/height:1600/1200 21:19:26 INFO - PROCESS | 2912 | colorDepth:24 21:19:26 INFO - PROCESS | 2912 | Browser inner width/height: 1010/674 21:19:26 INFO - PROCESS | 2912 | __metrics 21:19:27 INFO - PROCESS | 2912 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:19:27 INFO - PROCESS | 2912 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:19:27 INFO - PROCESS | 2912 | console.error: 21:19:27 INFO - PROCESS | 2912 | Message: Error: Connection closed before committing the transaction. 21:19:27 INFO - PROCESS | 2912 | Stack: 21:19:27 INFO - PROCESS | 2912 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 21:19:27 INFO - PROCESS | 2912 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 21:19:27 INFO - PROCESS | 2912 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 21:19:27 INFO - PROCESS | 2912 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 21:19:27 INFO - PROCESS | 2912 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 21:19:27 INFO - PROCESS | 2912 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 21:19:27 INFO - PROCESS | 2912 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 21:19:27 INFO - PROCESS | 2912 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 21:19:27 INFO - PROCESS | 2912 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 21:19:27 INFO - PROCESS | 2912 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 21:19:27 INFO - PROCESS | 2912 | Barrier/this.client.addBlocker/promise13.4% 21:20:25 INFO - TinderboxPrint: I/O read bytes / time
173,742,592 / 1,558,210 21:20:25 INFO - TinderboxPrint: I/O write bytes / time
410,349,568 / 3,624,590 21:20:25 INFO - TinderboxPrint: CPU idle
8,262.7 (86.6%) 21:20:25 INFO - TinderboxPrint: CPU user
1,230.9 (12.9%) 21:20:25 INFO - install - Wall time: 4s; CPU: 8.0%; Read bytes: 0; Write bytes: 64211968; Read time: 0; Write time: 188760 21:20:25 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 173742592; Write bytes: 306862080; Read time: 1558210; Write time: 3335550 21:20:25 INFO - Running post-run listener: _upload_blobber_files 21:20:25 INFO - Blob upload gear active. 21:20:25 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 21:20:25 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 21:20:25 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Autoland', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 21:20:25 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Autoland -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 21:20:26 INFO - (blobuploader) - INFO - Open directory for files ... 21:20:26 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 21:20:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:20:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:20:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:20:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:20:26 INFO - (blobuploader) - INFO - Done attempting. 21:20:26 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 21:20:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:20:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:20:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:20:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:20:27 INFO - (blobuploader) - INFO - Done attempting. 21:20:27 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 21:20:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:20:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:20:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:20:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:20:30 INFO - (blobuploader) - INFO - Done attempting. 21:20:30 INFO - (blobuploader) - INFO - Iteration through files over. 21:20:30 INFO - Return code: 0 21:20:30 INFO - rmtree: C:\slave\test\build\uploaded_files.json 21:20:30 INFO - Using _rmtree_windows ... 21:20:30 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 21:20:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7bba781c1723c3d829780a9dd465897597d78844daa241b9dc96970df5dff6b70340bb96ab56fd05c7aacbe275c6e039cd4504c1279a49b3081ad07c300a2ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/16b45731e5f0e8fcf992ffc44c6aad787b3ab57f35b7e143a8582e9377dabbba4ddae642e4cb4d7ac73c2ed53357ef2c011822a06626faa3027f24fd93421971", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/280a3dcc4e106dc005abf5a04ff59ffa31531013c72bc24e7a77350f33375da8665845342fa7a74608c6c685eeded8781bfed0630a1acdaacaf33ae6b9395422"} 21:20:30 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 21:20:30 INFO - Writing to file C:\slave\test\properties\blobber_files 21:20:30 INFO - Contents: 21:20:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7bba781c1723c3d829780a9dd465897597d78844daa241b9dc96970df5dff6b70340bb96ab56fd05c7aacbe275c6e039cd4504c1279a49b3081ad07c300a2ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/16b45731e5f0e8fcf992ffc44c6aad787b3ab57f35b7e143a8582e9377dabbba4ddae642e4cb4d7ac73c2ed53357ef2c011822a06626faa3027f24fd93421971", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/280a3dcc4e106dc005abf5a04ff59ffa31531013c72bc24e7a77350f33375da8665845342fa7a74608c6c685eeded8781bfed0630a1acdaacaf33ae6b9395422"} 21:20:30 INFO - Running post-run listener: copy_logs_to_upload_dir 21:20:30 INFO - Copying logs to upload dir... 21:20:30 INFO - mkdir: C:\slave\test\build\upload\logs 21:20:30 INFO - Copying logs to upload dir... 21:20:30 INFO - Using _rmtree_windows ... 21:20:30 INFO - Using _rmtree_windows ... 21:20:30 INFO - Using _rmtree_windows ... 21:20:30 INFO - Using _rmtree_windows ... 21:20:30 INFO - Using _rmtree_windows ... 21:20:30 INFO - Using _rmtree_windows ... 21:20:30 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1382.970000 ========= master_lag: 0.40 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 3 secs) (at 2016-11-02 21:20:30.021917) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 21:20:30.022786) ========= '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-032\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-032 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-032 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-032\AppData\Local LOGONSERVER=\\T-W864-IX-032 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-032 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-032 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-032 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7bba781c1723c3d829780a9dd465897597d78844daa241b9dc96970df5dff6b70340bb96ab56fd05c7aacbe275c6e039cd4504c1279a49b3081ad07c300a2ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/16b45731e5f0e8fcf992ffc44c6aad787b3ab57f35b7e143a8582e9377dabbba4ddae642e4cb4d7ac73c2ed53357ef2c011822a06626faa3027f24fd93421971", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/280a3dcc4e106dc005abf5a04ff59ffa31531013c72bc24e7a77350f33375da8665845342fa7a74608c6c685eeded8781bfed0630a1acdaacaf33ae6b9395422"} build_url:https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/KrWc0GNAS6KuQpaZnuf5nw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7bba781c1723c3d829780a9dd465897597d78844daa241b9dc96970df5dff6b70340bb96ab56fd05c7aacbe275c6e039cd4504c1279a49b3081ad07c300a2ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/16b45731e5f0e8fcf992ffc44c6aad787b3ab57f35b7e143a8582e9377dabbba4ddae642e4cb4d7ac73c2ed53357ef2c011822a06626faa3027f24fd93421971", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/280a3dcc4e106dc005abf5a04ff59ffa31531013c72bc24e7a77350f33375da8665845342fa7a74608c6c685eeded8781bfed0630a1acdaacaf33ae6b9395422"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 21:20:30.143766) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 21:20:30.144162) ========= '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-032\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-032 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-032 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-032\AppData\Local LOGONSERVER=\\T-W864-IX-032 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-032 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-032 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-032 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.100000 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 21:20:30.262247) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-11-02 21:20:30.262573) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-11-02 21:20:30.772314) ========= ========= Total master_lag: 0.59 =========