builder: mozilla-central_win8_64_test-dromaeojs-pgo slave: t-w864-ix-238 starttime: 1480678603.91 results: success (0) buildid: 20161202013003 builduid: e1e312a0c7b04f289f8707f4a1eed99c revision: f65ad27efe839ce9df0283840a1a40b4bbc9ead0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 03:36:43.909340) ========= master: http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 03:36:43.909761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 03:36:43.910062) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 03:36:44.399102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 03:36:44.399510) ========= '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-238\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-238 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-238 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-238\AppData\Local LOGONSERVER=\\T-W864-IX-238 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-238 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-238 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-238 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --03:36:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure HTTP request sent, awaiting response... 200 Script output follows Length: 12,179 (12K) [text/x-python] 0K .......... . 100% 8.28 MB/s 03:36:45 (8.28 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.996000 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 03:36:45.534987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-12-02 03:36:45.535335) ========= '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-238\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-238 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-238 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-238\AppData\Local LOGONSERVER=\\T-W864-IX-238 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-238 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-238 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-238 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.507000 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-12-02 03:36:48.208446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-02 03:36:48.208817) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev f65ad27efe839ce9df0283840a1a40b4bbc9ead0 --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f65ad27efe839ce9df0283840a1a40b4bbc9ead0 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-238\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-238 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-238 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-238\AppData\Local LOGONSERVER=\\T-W864-IX-238 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-238 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-238 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-238 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-12-02 03:36:48,500 truncating revision to first 12 chars 2016-12-02 03:36:48,500 Setting DEBUG logging. 2016-12-02 03:36:48,500 attempt 1/10 2016-12-02 03:36:48,500 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f65ad27efe83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 03:36:49,747 unpacking tar archive at: mozilla-central-f65ad27efe83/testing/mozharness/ 2016-12-02 03:36:49,855 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.779000 ========= master_lag: 0.51 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-02 03:36:50.492858) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 03:36:50.493252) ========= script_repo_revision: f65ad27efe839ce9df0283840a1a40b4bbc9ead0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 03:36:50.493680) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-12-02 03:36:50.493953) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-12-02 03:36:51.591423) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 47 secs) (at 2016-12-02 03:36:51.591837) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Firefox' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Firefox' in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-238\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-238 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-238 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-238\AppData\Local LOGONSERVER=\\T-W864-IX-238 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-238 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-238 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-238 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 03:36:52 INFO - MultiFileLogger online at 20161202 03:36:52 in C:\slave\test 03:36:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:36:52 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 03:36:52 INFO - {'append_to_log': False, 03:36:52 INFO - 'base_work_dir': 'C:\\slave\\test', 03:36:52 INFO - 'blob_upload_branch': 'Firefox', 03:36:52 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 03:36:52 INFO - 'branch': 'Firefox', 03:36:52 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:52 INFO - 'config_files': ('talos/windows_config.py',), 03:36:52 INFO - 'default_actions': ('clobber', 03:36:52 INFO - 'read-buildbot-config', 03:36:52 INFO - 'download-and-extract', 03:36:52 INFO - 'populate-webroot', 03:36:52 INFO - 'create-virtualenv', 03:36:52 INFO - 'install', 03:36:52 INFO - 'run-tests'), 03:36:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:52 INFO - 'download_minidump_stackwalk': True, 03:36:52 INFO - 'download_symbols': 'ondemand', 03:36:52 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 03:36:52 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 03:36:52 INFO - 'hg': 'c:/mozilla-build/hg/hg', 03:36:52 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 03:36:52 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 03:36:52 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 03:36:52 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 03:36:52 INFO - 'C:/mozilla-build/tooltool.py'), 03:36:52 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 03:36:52 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 03:36:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:52 INFO - 'installer_path': 'installer.exe', 03:36:52 INFO - 'log_level': 'info', 03:36:52 INFO - 'log_name': 'talos', 03:36:52 INFO - 'log_to_console': True, 03:36:52 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 03:36:52 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 03:36:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 03:36:52 INFO - 'opt_config_files': (), 03:36:52 INFO - 'pip_index': False, 03:36:52 INFO - 'sps_profile': False, 03:36:52 INFO - 'sps_profile_interval': 0, 03:36:52 INFO - 'suite': 'dromaeojs', 03:36:52 INFO - 'system_bits': '32', 03:36:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:52 INFO - 'title': 'T-W864-IX-238', 03:36:52 INFO - 'use_talos_json': True, 03:36:52 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 03:36:52 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 03:36:52 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 03:36:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:52 INFO - 'work_dir': 'build'} 03:36:52 INFO - [mozharness: 2016-12-02 11:36:52.036000Z] Running clobber step. 03:36:52 INFO - Running pre-action listener: _resource_record_pre_action 03:36:52 INFO - Running main action method: clobber 03:36:52 INFO - rmtree: C:\slave\test\build 03:36:52 INFO - Using _rmtree_windows ... 03:36:52 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 03:38:15 INFO - Running post-action listener: _resource_record_post_action 03:38:15 INFO - [mozharness: 2016-12-02 11:38:15.189000Z] Finished clobber step (success) 03:38:15 INFO - [mozharness: 2016-12-02 11:38:15.189000Z] Running read-buildbot-config step. 03:38:15 INFO - Running pre-action listener: _resource_record_pre_action 03:38:15 INFO - Running main action method: read_buildbot_config 03:38:15 INFO - Using buildbot properties: 03:38:15 INFO - { 03:38:15 INFO - "project": "", 03:38:15 INFO - "product": "firefox", 03:38:15 INFO - "script_repo_revision": "production", 03:38:15 INFO - "builddir": "mozilla-central_win8_64_test-dromaeojs", 03:38:15 INFO - "repository": "", 03:38:15 INFO - "buildername": "Windows 8 64-bit mozilla-central pgo talos dromaeojs", 03:38:15 INFO - "buildid": "20161202013003", 03:38:15 INFO - "pgo_build": "True", 03:38:15 INFO - "basedir": "C:\\slave\\test", 03:38:15 INFO - "buildnumber": 9, 03:38:15 INFO - "slavename": "t-w864-ix-238", 03:38:15 INFO - "master": "http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/", 03:38:15 INFO - "platform": "win8_64", 03:38:15 INFO - "scheduler": "tests-mozilla-central-win64-pgo-talos", 03:38:15 INFO - "branch": "mozilla-central", 03:38:15 INFO - "repo_path": "mozilla-central", 03:38:15 INFO - "revision": "f65ad27efe839ce9df0283840a1a40b4bbc9ead0", 03:38:15 INFO - "stage_platform": "win64-pgo", 03:38:15 INFO - "builduid": "e1e312a0c7b04f289f8707f4a1eed99c", 03:38:15 INFO - "slavebuilddir": "test" 03:38:15 INFO - } 03:38:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.zip. 03:38:15 INFO - Running post-action listener: _resource_record_post_action 03:38:15 INFO - [mozharness: 2016-12-02 11:38:15.192000Z] Finished read-buildbot-config step (success) 03:38:15 INFO - [mozharness: 2016-12-02 11:38:15.192000Z] Running download-and-extract step. 03:38:15 INFO - Running pre-action listener: _resource_record_pre_action 03:38:15 INFO - Running main action method: download_and_extract 03:38:15 INFO - mkdir: C:\slave\test\build\tests 03:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:15 INFO - trying https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.test_packages.json 03:38:15 INFO - Downloading https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-53.0a1.en-US.win64.test_packages.json 03:38:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-53.0a1.en-US.win64.test_packages.json'}, attempt #1 03:38:15 INFO - Downloaded 1218 bytes. 03:38:15 INFO - Reading from file C:\slave\test\build\firefox-53.0a1.en-US.win64.test_packages.json 03:38:15 INFO - Using the following test package requirements: 03:38:15 INFO - {u'common': [u'firefox-53.0a1.en-US.win64.common.tests.zip'], 03:38:15 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 03:38:15 INFO - u'firefox-53.0a1.en-US.win64.cppunittest.tests.zip'], 03:38:15 INFO - u'gtest': [u'firefox-53.0a1.en-US.win64.common.tests.zip'], 03:38:15 INFO - u'jittest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 03:38:15 INFO - u'jsshell-win64.zip'], 03:38:15 INFO - u'mochitest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 03:38:15 INFO - u'firefox-53.0a1.en-US.win64.mochitest.tests.zip'], 03:38:15 INFO - u'mozbase': [u'firefox-53.0a1.en-US.win64.common.tests.zip'], 03:38:15 INFO - u'reftest': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 03:38:15 INFO - u'firefox-53.0a1.en-US.win64.reftest.tests.zip'], 03:38:15 INFO - u'talos': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 03:38:15 INFO - u'firefox-53.0a1.en-US.win64.talos.tests.zip'], 03:38:15 INFO - u'web-platform': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 03:38:15 INFO - u'firefox-53.0a1.en-US.win64.web-platform.tests.zip'], 03:38:15 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.win64.common.tests.zip', 03:38:15 INFO - u'firefox-53.0a1.en-US.win64.xpcshell.tests.zip']} 03:38:15 INFO - Downloading packages: [u'firefox-53.0a1.en-US.win64.common.tests.zip'] for test suite category: common 03:38:15 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip 03:38:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip'}, attempt #1 03:38:15 INFO - Fetch https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip into memory 03:38:16 INFO - Expected file size: 17149469 03:38:16 INFO - Obtained file size: 17149469 03:38:39 INFO - Downloading packages: [u'firefox-53.0a1.en-US.win64.common.tests.zip', u'firefox-53.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 03:38:39 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip 03:38:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip'}, attempt #1 03:38:39 INFO - Fetch https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.common.tests.zip into memory 03:38:39 INFO - Expected file size: 17149469 03:38:39 INFO - Obtained file size: 17149469 03:38:48 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip 03:38:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip'}, attempt #1 03:38:48 INFO - Fetch https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.talos.tests.zip into memory 03:38:49 INFO - Expected file size: 14409734 03:38:49 INFO - Obtained file size: 14409734 03:38: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')]} 03:38:54 INFO - trying https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 03:38:54 INFO - Downloading https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.zip to C:\slave\test\build\firefox-53.0a1.en-US.win64.zip 03:38:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-53.0a1.en-US.win64.zip'}, attempt #1 03:38:55 INFO - Downloaded 57538409 bytes. 03:38:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 03:38:55 INFO - mkdir: C:\slave\test\properties 03:38:55 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 03:38:55 INFO - Writing to file C:\slave\test\properties\build_url 03:38:55 INFO - Contents: 03:38:55 INFO - build_url:https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.zip 03:38:56 INFO - Running post-action listener: _resource_record_post_action 03:38:56 INFO - Running post-action listener: set_extra_try_arguments 03:38:56 INFO - [mozharness: 2016-12-02 11:38:56.434000Z] Finished download-and-extract step (success) 03:38:56 INFO - [mozharness: 2016-12-02 11:38:56.434000Z] Running populate-webroot step. 03:38:56 INFO - Running pre-action listener: _resource_record_pre_action 03:38:56 INFO - Running main action method: populate_webroot 03:38:56 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 03:38:56 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 03:38:56 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 03:38:56 INFO - u'--tppagecycles', 03:38:56 INFO - u'7'], 03:38:56 INFO - u'tests': [u'tsvgm']}}, 03:38:56 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 03:38:56 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 03:38:56 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 03:38:56 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 03:38:56 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 03:38:56 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 03:38:56 INFO - u'g1': {u'pagesets_name': u'tp5n.zip', 03:38:56 INFO - u'talos_options': [u'--disable-e10s'], 03:38:56 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 03:38:56 INFO - u'g1-e10s': {u'pagesets_name': u'tp5n.zip', 03:38:56 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 03:38:56 INFO - u'g2': {u'pagesets_name': u'tp5n.zip', 03:38:56 INFO - u'talos_options': [u'--disable-e10s'], 03:38:56 INFO - u'tests': [u'damp', u'tps']}, 03:38:56 INFO - u'g2-e10s': {u'pagesets_name': u'tp5n.zip', 03:38:56 INFO - u'tests': [u'damp', u'tps']}, 03:38:56 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 03:38:56 INFO - u'tests': [u'dromaeo_dom']}, 03:38:56 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 03:38:56 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 03:38:56 INFO - u'tests': [u'basic_compositor_video']}, 03:38:56 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 03:38:56 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 03:38:56 INFO - u'tests': [u'a11yr', 03:38:56 INFO - u'ts_paint', 03:38:56 INFO - u'tpaint', 03:38:56 INFO - u'sessionrestore', 03:38:56 INFO - u'sessionrestore_no_auto_restore', 03:38:56 INFO - u'tabpaint']}, 03:38:56 INFO - u'other-e10s': {u'tests': [u'a11yr', 03:38:56 INFO - u'ts_paint', 03:38:56 INFO - u'tpaint', 03:38:56 INFO - u'sessionrestore', 03:38:56 INFO - u'sessionrestore_no_auto_restore', 03:38:56 INFO - u'tabpaint']}, 03:38:56 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 03:38:56 INFO - u'ts_paint', 03:38:56 INFO - u'tpaint', 03:38:56 INFO - u'sessionrestore', 03:38:56 INFO - u'sessionrestore_no_auto_restore', 03:38:56 INFO - u'tabpaint']}, 03:38:56 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 03:38:56 INFO - u'ts_paint', 03:38:56 INFO - u'tpaint', 03:38:56 INFO - u'sessionrestore', 03:38:56 INFO - u'sessionrestore_no_auto_restore', 03:38:56 INFO - u'tabpaint']}, 03:38:56 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 03:38:56 INFO - u'tests': [u'a11yr', 03:38:56 INFO - u'ts_paint', 03:38:56 INFO - u'tpaint', 03:38:56 INFO - u'sessionrestore', 03:38:56 INFO - u'sessionrestore_no_auto_restore', 03:38:56 INFO - u'tabpaint']}, 03:38:56 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 03:38:56 INFO - u'tests': [u'a11yr', 03:38:56 INFO - u'ts_paint', 03:38:56 INFO - u'tpaint', 03:38:56 INFO - u'sessionrestore', 03:38:56 INFO - u'sessionrestore_no_auto_restore', 03:38:56 INFO - u'tabpaint']}, 03:38:56 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 03:38:56 INFO - u'tests': [u'tsvgx', 03:38:56 INFO - u'tsvgr_opacity', 03:38:56 INFO - u'tart', 03:38:56 INFO - u'tscrollx', 03:38:56 INFO - u'cart', 03:38:56 INFO - u'tsvg_static']}, 03:38:56 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 03:38:56 INFO - u'tsvgr_opacity', 03:38:56 INFO - u'tart', 03:38:56 INFO - u'tscrollx', 03:38:56 INFO - u'cart', 03:38:56 INFO - u'tsvg_static']}, 03:38:56 INFO - u'tp5o': {u'pagesets_name': u'tp5n.zip', 03:38:56 INFO - u'talos_options': [u'--disable-e10s'], 03:38:56 INFO - u'tests': [u'tp5o']}, 03:38:56 INFO - u'tp5o-e10s': {u'pagesets_name': u'tp5n.zip', 03:38:56 INFO - u'tests': [u'tp5o']}, 03:38:56 INFO - u'xperf': {u'pagesets_name': u'tp5n.zip', 03:38:56 INFO - u'talos_options': [u'--disable-e10s', 03:38:56 INFO - u'--xperf_path', 03:38:56 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:56 INFO - u'tests': [u'tp5n']}, 03:38:56 INFO - u'xperf-e10s': {u'pagesets_name': u'tp5n.zip', 03:38:56 INFO - u'talos_options': [u'--xperf_path', 03:38:56 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:56 INFO - u'tests': [u'tp5n']}}, 03:38:56 INFO - u'talos.zip': {u'path': u'', 03:38:56 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:38:56 INFO - Running post-action listener: _resource_record_post_action 03:38:56 INFO - [mozharness: 2016-12-02 11:38:56.501000Z] Finished populate-webroot step (success) 03:38:56 INFO - [mozharness: 2016-12-02 11:38:56.501000Z] Running create-virtualenv step. 03:38:56 INFO - Running pre-action listener: _resource_record_pre_action 03:38:56 INFO - Running main action method: create_virtualenv 03:38:56 INFO - Creating virtualenv C:\slave\test\build/venv 03:38:56 INFO - mkdir: C:\slave\test\build\venv\Scripts 03:38:56 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 03:38:56 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'! 03:38:56 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 03:38:56 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 03:39:03 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 03:39:07 INFO - Installing distribute......................................................................................................................................................................................done. 03:39:08 INFO - Return code: 0 03:39:08 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 03:39:08 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 03:39:08 INFO - Reading from file tmpfile_stdout 03:39:08 INFO - Output received: 03:39:08 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 03:39:08 INFO - Using _rmtree_windows ... 03:39:08 INFO - Using _rmtree_windows ... 03:39:08 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 03:39: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')]} 03:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39: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')]} 03:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025A4F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00443F90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025C5E90>, '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 0x003BA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029C65C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-238', 'USERDOMAIN': 'T-W864-IX-238', '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-238', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-238', '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-238\\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 03:39:09 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 03:39:09 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 03:39:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:39:09 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Roaming', 03:39:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 03:39:09 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 03:39:09 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 03:39:09 INFO - 'COMPUTERNAME': 'T-W864-IX-238', 03:39:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:39:09 INFO - 'DCLOCATION': 'SCL3', 03:39:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:39:09 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:39:09 INFO - 'HOMEDRIVE': 'C:', 03:39:09 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 03:39:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:39:09 INFO - 'KTS_VERSION': '1.19c', 03:39:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 03:39:09 INFO - 'LOGONSERVER': '\\\\T-W864-IX-238', 03:39:09 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:39:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:09 INFO - 'MOZ_NO_REMOTE': '1', 03:39:09 INFO - 'NO_EM_RESTART': '1', 03:39:09 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:39:09 INFO - 'OS': 'Windows_NT', 03:39:09 INFO - 'OURDRIVE': 'C:', 03:39:09 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', 03:39:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:39:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:39:09 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 03:39:09 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 03:39:09 INFO - 'PROCESSOR_LEVEL': '6', 03:39:09 INFO - 'PROCESSOR_REVISION': '1e05', 03:39:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:39:09 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 03:39:09 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 03:39:09 INFO - 'PROGRAMW6432': 'C:\\Program Files', 03:39:09 INFO - 'PROMPT': '$P$G', 03:39:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:39:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:39:09 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:39:09 INFO - 'PWD': 'C:\\slave\\test', 03:39:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:39:09 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:39:09 INFO - 'SYSTEMDRIVE': 'C:', 03:39:09 INFO - 'SYSTEMROOT': 'C:\\windows', 03:39:09 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:09 INFO - 'TEST1': 'testie', 03:39:09 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:09 INFO - 'USERDOMAIN': 'T-W864-IX-238', 03:39:09 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 03:39:09 INFO - 'USERNAME': 'cltbld', 03:39:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-238', 03:39:09 INFO - 'WINDIR': 'C:\\windows', 03:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:39:09 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:39:09 INFO - Downloading/unpacking pip>=1.5 03:39:13 INFO - Running setup.py egg_info for package pip 03:39:13 INFO - warning: no files found matching 'pip\cacert.pem' 03:39:13 INFO - warning: no files found matching '*.html' under directory 'docs' 03:39:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 03:39:13 INFO - no previously-included directories found matching 'docs\_build\_sources' 03:39:13 INFO - Installing collected packages: pip 03:39:13 INFO - Found existing installation: pip 0.8.2 03:39:13 INFO - Uninstalling pip: 03:39:13 INFO - Successfully uninstalled pip 03:39:13 INFO - Running setup.py install for pip 03:39:13 INFO - warning: no files found matching 'pip\cacert.pem' 03:39:13 INFO - warning: no files found matching '*.html' under directory 'docs' 03:39:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 03:39:13 INFO - no previously-included directories found matching 'docs\_build\_sources' 03:39:13 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 03:39:13 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 03:39:13 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 03:39:13 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 03:39:13 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 03:39:13 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 03:39:13 INFO - Successfully installed pip 03:39:13 INFO - Cleaning up... 03:39:13 INFO - Return code: 0 03:39:13 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 03:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:13 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x024FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025A4F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00443F90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025C5E90>, '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 0x003BA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029C65C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-238', 'USERDOMAIN': 'T-W864-IX-238', '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-238', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-238', '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-238\\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 03:39:14 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 03:39:14 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 03:39:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:39:14 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Roaming', 03:39:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 03:39:14 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 03:39:14 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 03:39:14 INFO - 'COMPUTERNAME': 'T-W864-IX-238', 03:39:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:39:14 INFO - 'DCLOCATION': 'SCL3', 03:39:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:39:14 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:39:14 INFO - 'HOMEDRIVE': 'C:', 03:39:14 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 03:39:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:39:14 INFO - 'KTS_VERSION': '1.19c', 03:39:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 03:39:14 INFO - 'LOGONSERVER': '\\\\T-W864-IX-238', 03:39:14 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:39:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:14 INFO - 'MOZ_NO_REMOTE': '1', 03:39:14 INFO - 'NO_EM_RESTART': '1', 03:39:14 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:39:14 INFO - 'OS': 'Windows_NT', 03:39:14 INFO - 'OURDRIVE': 'C:', 03:39:14 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', 03:39:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:39:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:39:14 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 03:39:14 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 03:39:14 INFO - 'PROCESSOR_LEVEL': '6', 03:39:14 INFO - 'PROCESSOR_REVISION': '1e05', 03:39:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:39:14 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 03:39:14 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 03:39:14 INFO - 'PROGRAMW6432': 'C:\\Program Files', 03:39:14 INFO - 'PROMPT': '$P$G', 03:39:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:39:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:39:14 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:39:14 INFO - 'PWD': 'C:\\slave\\test', 03:39:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:39:14 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:39:14 INFO - 'SYSTEMDRIVE': 'C:', 03:39:14 INFO - 'SYSTEMROOT': 'C:\\windows', 03:39:14 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:14 INFO - 'TEST1': 'testie', 03:39:14 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:14 INFO - 'USERDOMAIN': 'T-W864-IX-238', 03:39:14 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 03:39:14 INFO - 'USERNAME': 'cltbld', 03:39:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-238', 03:39:14 INFO - 'WINDIR': 'C:\\windows', 03:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:15 INFO - Downloading/unpacking psutil>=3.1.1 03:39:15 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 03:39:15 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 03:39:16 INFO - Installing collected packages: psutil 03:39:16 INFO - Successfully installed psutil 03:39:16 INFO - Cleaning up... 03:39:16 INFO - Return code: 0 03:39:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 03:39:16 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')]} 03:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:16 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')]} 03:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:16 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 0x024FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025A4F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00443F90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025C5E90>, '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 0x003BA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029C65C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-238', 'USERDOMAIN': 'T-W864-IX-238', '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-238', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-238', '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-238\\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 03:39:16 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 03:39:16 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 03:39:16 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:39:16 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Roaming', 03:39:16 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 03:39:16 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 03:39:16 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 03:39:16 INFO - 'COMPUTERNAME': 'T-W864-IX-238', 03:39:16 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:39:16 INFO - 'DCLOCATION': 'SCL3', 03:39:16 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:39:16 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:39:16 INFO - 'HOMEDRIVE': 'C:', 03:39:16 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 03:39:16 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:39:16 INFO - 'KTS_VERSION': '1.19c', 03:39:16 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 03:39:16 INFO - 'LOGONSERVER': '\\\\T-W864-IX-238', 03:39:16 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:39:16 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:16 INFO - 'MOZ_NO_REMOTE': '1', 03:39:16 INFO - 'NO_EM_RESTART': '1', 03:39:16 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:39:16 INFO - 'OS': 'Windows_NT', 03:39:16 INFO - 'OURDRIVE': 'C:', 03:39:16 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', 03:39:16 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:39:16 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:39:16 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 03:39:16 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 03:39:16 INFO - 'PROCESSOR_LEVEL': '6', 03:39:16 INFO - 'PROCESSOR_REVISION': '1e05', 03:39:16 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:39:16 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 03:39:16 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 03:39:16 INFO - 'PROGRAMW6432': 'C:\\Program Files', 03:39:16 INFO - 'PROMPT': '$P$G', 03:39:16 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:39:16 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:39:16 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:39:16 INFO - 'PWD': 'C:\\slave\\test', 03:39:16 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:39:16 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:39:16 INFO - 'SYSTEMDRIVE': 'C:', 03:39:16 INFO - 'SYSTEMROOT': 'C:\\windows', 03:39:16 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:16 INFO - 'TEST1': 'testie', 03:39:16 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:16 INFO - 'USERDOMAIN': 'T-W864-IX-238', 03:39:16 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 03:39:16 INFO - 'USERNAME': 'cltbld', 03:39:16 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-238', 03:39:16 INFO - 'WINDIR': 'C:\\windows', 03:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:39:18 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 03:39:18 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) 03:39:18 INFO - Installing collected packages: mozsystemmonitor 03:39:18 INFO - Running setup.py install for mozsystemmonitor 03:39:18 INFO - Successfully installed mozsystemmonitor 03:39:18 INFO - Cleaning up... 03:39:18 INFO - Return code: 0 03:39:18 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 03:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:18 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x024FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025A4F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00443F90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025C5E90>, '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 0x003BA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029C65C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-238', 'USERDOMAIN': 'T-W864-IX-238', '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-238', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-238', '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-238\\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 03:39:18 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build 03:39:18 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:39:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:39:18 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Roaming', 03:39:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 03:39:18 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 03:39:18 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 03:39:18 INFO - 'COMPUTERNAME': 'T-W864-IX-238', 03:39:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:39:18 INFO - 'DCLOCATION': 'SCL3', 03:39:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:39:18 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:39:18 INFO - 'HOMEDRIVE': 'C:', 03:39:18 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 03:39:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:39:18 INFO - 'KTS_VERSION': '1.19c', 03:39:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 03:39:18 INFO - 'LOGONSERVER': '\\\\T-W864-IX-238', 03:39:18 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:39:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:18 INFO - 'MOZ_NO_REMOTE': '1', 03:39:18 INFO - 'NO_EM_RESTART': '1', 03:39:18 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:39:18 INFO - 'OS': 'Windows_NT', 03:39:18 INFO - 'OURDRIVE': 'C:', 03:39:18 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 03:39:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:39:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:39:18 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 03:39:18 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 03:39:18 INFO - 'PROCESSOR_LEVEL': '6', 03:39:18 INFO - 'PROCESSOR_REVISION': '1e05', 03:39:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:39:18 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 03:39:18 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 03:39:18 INFO - 'PROGRAMW6432': 'C:\\Program Files', 03:39:18 INFO - 'PROMPT': '$P$G', 03:39:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:39:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:39:18 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:39:18 INFO - 'PWD': 'C:\\slave\\test', 03:39:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:39:18 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:39:18 INFO - 'SYSTEMDRIVE': 'C:', 03:39:18 INFO - 'SYSTEMROOT': 'C:\\windows', 03:39:18 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:18 INFO - 'TEST1': 'testie', 03:39:18 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:18 INFO - 'USERDOMAIN': 'T-W864-IX-238', 03:39:18 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 03:39:18 INFO - 'USERNAME': 'cltbld', 03:39:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-238', 03:39:18 INFO - 'WINDIR': 'C:\\windows', 03:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:19 INFO - Downloading/unpacking jsonschema==2.5.1 03:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:39:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:20 INFO - Downloading functools32-3.2.3-2.tar.gz 03:39:20 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 03:39:20 INFO - warning: no files found matching '*.txt' 03:39:20 INFO - no previously-included directories found matching 'build' 03:39:20 INFO - no previously-included directories found matching 'dist' 03:39:20 INFO - no previously-included directories found matching '.git*' 03:39:20 INFO - Installing collected packages: jsonschema, functools32 03:39:20 INFO - Running setup.py install for functools32 03:39:20 INFO - warning: no files found matching '*.txt' 03:39:20 INFO - no previously-included directories found matching 'build' 03:39:20 INFO - no previously-included directories found matching 'dist' 03:39:20 INFO - no previously-included directories found matching '.git*' 03:39:20 INFO - Successfully installed jsonschema functools32 03:39:20 INFO - Cleaning up... 03:39:21 INFO - Return code: 0 03:39:21 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 03:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:21 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x024FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025A4F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00443F90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025C5E90>, '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 0x003BA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029C65C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-238', 'USERDOMAIN': 'T-W864-IX-238', '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-238', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-238', '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-238\\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 03:39:21 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 03:39:21 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:39:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:39:21 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Roaming', 03:39:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 03:39:21 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 03:39:21 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 03:39:21 INFO - 'COMPUTERNAME': 'T-W864-IX-238', 03:39:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:39:21 INFO - 'DCLOCATION': 'SCL3', 03:39:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:39:21 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:39:21 INFO - 'HOMEDRIVE': 'C:', 03:39:21 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 03:39:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:39:21 INFO - 'KTS_VERSION': '1.19c', 03:39:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 03:39:21 INFO - 'LOGONSERVER': '\\\\T-W864-IX-238', 03:39:21 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:39:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:21 INFO - 'MOZ_NO_REMOTE': '1', 03:39:21 INFO - 'NO_EM_RESTART': '1', 03:39:21 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:39:21 INFO - 'OS': 'Windows_NT', 03:39:21 INFO - 'OURDRIVE': 'C:', 03:39:21 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 03:39:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:39:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:39:21 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 03:39:21 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 03:39:21 INFO - 'PROCESSOR_LEVEL': '6', 03:39:21 INFO - 'PROCESSOR_REVISION': '1e05', 03:39:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:39:21 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 03:39:21 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 03:39:21 INFO - 'PROGRAMW6432': 'C:\\Program Files', 03:39:21 INFO - 'PROMPT': '$P$G', 03:39:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:39:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:39:21 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:39:21 INFO - 'PWD': 'C:\\slave\\test', 03:39:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:39:21 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:39:21 INFO - 'SYSTEMDRIVE': 'C:', 03:39:21 INFO - 'SYSTEMROOT': 'C:\\windows', 03:39:21 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:21 INFO - 'TEST1': 'testie', 03:39:21 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:21 INFO - 'USERDOMAIN': 'T-W864-IX-238', 03:39:21 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 03:39:21 INFO - 'USERNAME': 'cltbld', 03:39:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-238', 03:39:21 INFO - 'WINDIR': 'C:\\windows', 03:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 03:39:21 INFO - Cleaning up... 03:39:21 INFO - Return code: 0 03:39:21 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 03:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:21 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x024FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025A4F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00443F90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025C5E90>, '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 0x003BA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029C65C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-238', 'USERDOMAIN': 'T-W864-IX-238', '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-238', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-238', '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-238\\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 03:39:21 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build 03:39:21 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:39:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:39:21 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Roaming', 03:39:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 03:39:21 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 03:39:21 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 03:39:21 INFO - 'COMPUTERNAME': 'T-W864-IX-238', 03:39:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:39:21 INFO - 'DCLOCATION': 'SCL3', 03:39:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:39:21 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:39:21 INFO - 'HOMEDRIVE': 'C:', 03:39:21 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 03:39:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:39:21 INFO - 'KTS_VERSION': '1.19c', 03:39:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 03:39:21 INFO - 'LOGONSERVER': '\\\\T-W864-IX-238', 03:39:21 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:39:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:21 INFO - 'MOZ_NO_REMOTE': '1', 03:39:21 INFO - 'NO_EM_RESTART': '1', 03:39:21 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:39:21 INFO - 'OS': 'Windows_NT', 03:39:21 INFO - 'OURDRIVE': 'C:', 03:39:21 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 03:39:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:39:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:39:21 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 03:39:21 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 03:39:21 INFO - 'PROCESSOR_LEVEL': '6', 03:39:21 INFO - 'PROCESSOR_REVISION': '1e05', 03:39:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:39:21 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 03:39:21 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 03:39:21 INFO - 'PROGRAMW6432': 'C:\\Program Files', 03:39:21 INFO - 'PROMPT': '$P$G', 03:39:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:39:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:39:21 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:39:21 INFO - 'PWD': 'C:\\slave\\test', 03:39:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:39:21 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:39:21 INFO - 'SYSTEMDRIVE': 'C:', 03:39:21 INFO - 'SYSTEMROOT': 'C:\\windows', 03:39:21 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:21 INFO - 'TEST1': 'testie', 03:39:21 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:21 INFO - 'USERDOMAIN': 'T-W864-IX-238', 03:39:21 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 03:39:21 INFO - 'USERNAME': 'cltbld', 03:39:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-238', 03:39:21 INFO - 'WINDIR': 'C:\\windows', 03:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:21 INFO - Downloading/unpacking blobuploader==1.2.4 03:39:21 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 03:39:21 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 03:39:22 INFO - Downloading blobuploader-1.2.4.tar.gz 03:39:22 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 03:39:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:39:22 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 03:39:22 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 03:39:23 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 03:39:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:39:23 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 03:39:23 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 03:39:23 INFO - Downloading docopt-0.6.1.tar.gz 03:39:23 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 03:39:23 INFO - Installing collected packages: blobuploader, requests, docopt 03:39:23 INFO - Running setup.py install for blobuploader 03:39:23 INFO - Running setup.py install for requests 03:39:24 INFO - Running setup.py install for docopt 03:39:24 INFO - Successfully installed blobuploader requests docopt 03:39:24 INFO - Cleaning up... 03:39:25 INFO - Return code: 0 03:39:25 INFO - Installing None into virtualenv C:\slave\test\build/venv 03:39:25 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')]} 03:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:25 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')]} 03:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:25 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 0x024FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025A4F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00443F90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025C5E90>, '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 0x003BA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029C65C0>, '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-238', 'USERDOMAIN': 'T-W864-IX-238', '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-238', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-238', '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-238\\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 03:39:25 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 03:39:25 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 03:39:25 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:39:25 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Roaming', 03:39:25 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 03:39:25 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 03:39:25 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 03:39:25 INFO - 'COMPUTERNAME': 'T-W864-IX-238', 03:39:25 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:39:25 INFO - 'DCLOCATION': 'SCL3', 03:39:25 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:39:25 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:39:25 INFO - 'HOMEDRIVE': 'C:', 03:39:25 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 03:39:25 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:39:25 INFO - 'KTS_VERSION': '1.19c', 03:39:25 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 03:39:25 INFO - 'LOGONSERVER': '\\\\T-W864-IX-238', 03:39:25 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:39:25 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:25 INFO - 'MOZ_NO_REMOTE': '1', 03:39:25 INFO - 'NO_EM_RESTART': '1', 03:39:25 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:39:25 INFO - 'OS': 'Windows_NT', 03:39:25 INFO - 'OURDRIVE': 'C:', 03:39:25 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', 03:39:25 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:39:25 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:39:25 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 03:39:25 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 03:39:25 INFO - 'PROCESSOR_LEVEL': '6', 03:39:25 INFO - 'PROCESSOR_REVISION': '1e05', 03:39:25 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:39:25 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 03:39:25 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 03:39:25 INFO - 'PROGRAMW6432': 'C:\\Program Files', 03:39:25 INFO - 'PROMPT': '$P$G', 03:39:25 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:39:25 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:39:25 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:39:25 INFO - 'PWD': 'C:\\slave\\test', 03:39:25 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:39:25 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:39:25 INFO - 'SYSTEMDRIVE': 'C:', 03:39:25 INFO - 'SYSTEMROOT': 'C:\\windows', 03:39:25 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:25 INFO - 'TEST1': 'testie', 03:39:25 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:25 INFO - 'USERDOMAIN': 'T-W864-IX-238', 03:39:25 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 03:39:25 INFO - 'USERNAME': 'cltbld', 03:39:25 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-238', 03:39:25 INFO - 'WINDIR': 'C:\\windows', 03:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:25 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 03:39:25 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-08ino6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 03:39:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 03:39:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-soy1pd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 03:39:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 03:39:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-d0n1ge-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 03:39:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 03:39:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rk2r3z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 03:39:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 03:39:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-v9enpc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 03:39:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 03:39:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-g0xclx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 03:39:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 03:39:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-n2zyob-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 03:39:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 03:39:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dowo6k-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 03:39:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 03:39:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-epecoa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 03:39:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 03:39:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kbhhkb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 03:39:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 03:39:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-s4wmsp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 03:39:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 03:39:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qseccc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 03:39:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 03:39:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-znengn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 03:39:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 03:39:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-b4j34n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 03:39:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 03:39:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8gzpsl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 03:39:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 03:39:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xbqtnx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 03:39:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 03:39:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mn7hfd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 03:39:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:39:27 INFO - Running setup.py install for manifestparser 03:39:28 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 03:39:28 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 03:39:28 INFO - Running setup.py install for mozcrash 03:39:28 INFO - Running setup.py install for mozdebug 03:39:29 INFO - Running setup.py install for mozdevice 03:39:29 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 03:39:29 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 03:39:29 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 03:39:29 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 03:39:29 INFO - Running setup.py install for mozfile 03:39:30 INFO - Running setup.py install for mozhttpd 03:39:30 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 03:39:30 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 03:39:30 INFO - Running setup.py install for mozinfo 03:39:30 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 03:39:30 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 03:39:31 INFO - Running setup.py install for mozInstall 03:39:31 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 03:39:31 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 03:39:31 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 03:39:31 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 03:39:31 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 03:39:31 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 03:39:31 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 03:39:31 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 03:39:31 INFO - Running setup.py install for mozleak 03:39:31 INFO - Running setup.py install for mozlog 03:39:31 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 03:39:31 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 03:39:32 INFO - Running setup.py install for moznetwork 03:39:32 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 03:39:32 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 03:39:32 INFO - Running setup.py install for mozprocess 03:39:33 INFO - Running setup.py install for mozprofile 03:39:33 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 03:39:33 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 03:39:33 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 03:39:33 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 03:39:33 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 03:39:33 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 03:39:34 INFO - Running setup.py install for mozrunner 03:39:34 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 03:39:34 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 03:39:34 INFO - Running setup.py install for mozscreenshot 03:39:35 INFO - Running setup.py install for moztest 03:39:35 INFO - Running setup.py install for mozversion 03:39:35 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 03:39:35 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 03:39:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:39:35 INFO - Cleaning up... 03:39:35 INFO - Return code: 0 03:39:35 INFO - Installing None into virtualenv C:\slave\test\build/venv 03:39: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')]} 03:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39: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')]} 03:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:35 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 0x024FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025A4F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00443F90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025C5E90>, '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 0x003BA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029C65C0>, '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-238', 'USERDOMAIN': 'T-W864-IX-238', '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-238', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-238', '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-238\\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 03:39:35 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 03:39:35 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 03:39:35 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:39:35 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Roaming', 03:39:35 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 03:39:35 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 03:39:35 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 03:39:35 INFO - 'COMPUTERNAME': 'T-W864-IX-238', 03:39:35 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:39:35 INFO - 'DCLOCATION': 'SCL3', 03:39:35 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:39:35 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:39:35 INFO - 'HOMEDRIVE': 'C:', 03:39:35 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 03:39:35 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:39:35 INFO - 'KTS_VERSION': '1.19c', 03:39:35 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 03:39:35 INFO - 'LOGONSERVER': '\\\\T-W864-IX-238', 03:39:35 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:39:35 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:35 INFO - 'MOZ_NO_REMOTE': '1', 03:39:35 INFO - 'NO_EM_RESTART': '1', 03:39:35 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:39:35 INFO - 'OS': 'Windows_NT', 03:39:35 INFO - 'OURDRIVE': 'C:', 03:39:35 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 03:39:35 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:39:35 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:39:35 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 03:39:35 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 03:39:35 INFO - 'PROCESSOR_LEVEL': '6', 03:39:35 INFO - 'PROCESSOR_REVISION': '1e05', 03:39:35 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:39:35 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 03:39:35 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 03:39:35 INFO - 'PROGRAMW6432': 'C:\\Program Files', 03:39:35 INFO - 'PROMPT': '$P$G', 03:39:35 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:39:35 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:39:35 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:39:35 INFO - 'PWD': 'C:\\slave\\test', 03:39:35 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:39:35 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:39:35 INFO - 'SYSTEMDRIVE': 'C:', 03:39:35 INFO - 'SYSTEMROOT': 'C:\\windows', 03:39:35 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:35 INFO - 'TEST1': 'testie', 03:39:35 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:35 INFO - 'USERDOMAIN': 'T-W864-IX-238', 03:39:35 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 03:39:35 INFO - 'USERNAME': 'cltbld', 03:39:35 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-238', 03:39:35 INFO - 'WINDIR': 'C:\\windows', 03:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 03:39:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-e7hvmz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 03:39:36 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)) 03:39:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 03:39:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-p_wonn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 03:39:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 03:39:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 03:39:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-h7ctre-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 03:39:36 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)) 03:39:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 03:39:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xlstbs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 03:39:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 03:39:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 03:39:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-a4zq01-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 03:39:36 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)) 03:39:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 03:39:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-juj6_p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 03:39:36 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)) 03:39:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 03:39:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pm6zsl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 03:39:36 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)) 03:39:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 03:39:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mwukcc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 03:39:37 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)) 03:39:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 03:39:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bijvuk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 03:39:37 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)) 03:39:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 03:39:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bppdu4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 03:39:37 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)) 03:39:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 03:39:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gzceta-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 03:39:37 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)) 03:39:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 03:39:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rkgdu1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 03:39:37 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)) 03:39:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 03:39:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1vqo5j-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 03:39:37 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)) 03:39:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 03:39:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lk5f7g-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 03:39:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 03:39:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 03:39:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mfvrpa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 03:39:37 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)) 03:39:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 03:39:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6lecsv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 03:39:38 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)) 03:39:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 03:39:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eemsiz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 03:39:38 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)) 03:39:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 03:39:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 03:39:38 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)) 03:39:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.49->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 03:39:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.49->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 03:39:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 03:39:38 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 03:39:38 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 03:39:39 INFO - Downloading blessings-1.6.tar.gz 03:39:39 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 03:39:39 INFO - Installing collected packages: blessings 03:39:39 INFO - Running setup.py install for blessings 03:39:39 INFO - Successfully installed blessings 03:39:39 INFO - Cleaning up... 03:39:42 INFO - Return code: 0 03:39:42 INFO - Done creating virtualenv C:\slave\test\build/venv. 03:39:42 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 03:39:42 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 03:39:42 INFO - Reading from file tmpfile_stdout 03:39:42 INFO - Using _rmtree_windows ... 03:39:42 INFO - Using _rmtree_windows ... 03:39:42 INFO - Current package versions: 03:39:42 INFO - blessings == 1.6 03:39:42 INFO - blobuploader == 1.2.4 03:39:42 INFO - docopt == 0.6.1 03:39:42 INFO - functools32 == 3.2.3-2 03:39:42 INFO - jsonschema == 2.5.1 03:39:42 INFO - manifestparser == 1.1 03:39:42 INFO - mozInstall == 1.12 03:39:42 INFO - mozcrash == 1.0 03:39:42 INFO - mozdebug == 0.1 03:39:42 INFO - mozdevice == 0.49 03:39:42 INFO - mozfile == 1.2 03:39:42 INFO - mozhttpd == 0.7 03:39:42 INFO - mozinfo == 0.9 03:39:42 INFO - mozleak == 0.1 03:39:42 INFO - mozlog == 3.4 03:39:42 INFO - moznetwork == 0.27 03:39:42 INFO - mozprocess == 0.23 03:39:42 INFO - mozprofile == 0.28 03:39:42 INFO - mozrunner == 6.13 03:39:42 INFO - mozscreenshot == 0.1 03:39:42 INFO - mozsystemmonitor == 0.3 03:39:42 INFO - moztest == 0.7 03:39:42 INFO - mozversion == 1.4 03:39:42 INFO - psutil == 3.1.1 03:39:42 INFO - requests == 1.2.3 03:39:42 INFO - Installing None into virtualenv C:\slave\test\build/venv 03:39:42 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')]} 03:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:42 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')]} 03:39:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:42 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 0x024FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025A4F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00443F90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025C5E90>, '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 0x003BA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029C65C0>, '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-238', 'USERDOMAIN': 'T-W864-IX-238', '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-238', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-238', '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-238\\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 03:39:42 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 03:39:42 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 03:39:42 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:39:42 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Roaming', 03:39:42 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 03:39:42 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 03:39:42 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 03:39:42 INFO - 'COMPUTERNAME': 'T-W864-IX-238', 03:39:42 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:39:42 INFO - 'DCLOCATION': 'SCL3', 03:39:42 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:39:42 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:39:42 INFO - 'HOMEDRIVE': 'C:', 03:39:42 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 03:39:42 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:39:42 INFO - 'KTS_VERSION': '1.19c', 03:39:42 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 03:39:42 INFO - 'LOGONSERVER': '\\\\T-W864-IX-238', 03:39:42 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:39:42 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:39:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:42 INFO - 'MOZ_NO_REMOTE': '1', 03:39:42 INFO - 'NO_EM_RESTART': '1', 03:39:42 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:39:42 INFO - 'OS': 'Windows_NT', 03:39:42 INFO - 'OURDRIVE': 'C:', 03:39:42 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', 03:39:42 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:39:42 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:39:42 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 03:39:42 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 03:39:42 INFO - 'PROCESSOR_LEVEL': '6', 03:39:42 INFO - 'PROCESSOR_REVISION': '1e05', 03:39:42 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:39:42 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 03:39:42 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 03:39:42 INFO - 'PROGRAMW6432': 'C:\\Program Files', 03:39:42 INFO - 'PROMPT': '$P$G', 03:39:42 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:39:42 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:39:42 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:39:42 INFO - 'PWD': 'C:\\slave\\test', 03:39:42 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:39:42 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:39:42 INFO - 'SYSTEMDRIVE': 'C:', 03:39:42 INFO - 'SYSTEMROOT': 'C:\\windows', 03:39:42 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:42 INFO - 'TEST1': 'testie', 03:39:42 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:42 INFO - 'USERDOMAIN': 'T-W864-IX-238', 03:39:42 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 03:39:42 INFO - 'USERNAME': 'cltbld', 03:39:42 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-238', 03:39:42 INFO - 'WINDIR': 'C:\\windows', 03:39:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:43 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)) 03:39:43 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)) 03:39:43 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)) 03:39:43 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)) 03:39:43 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)) 03:39:43 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)) 03:39:43 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)) 03:39:43 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)) 03:39:43 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)) 03:39:43 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)) 03:39:43 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)) 03:39:43 INFO - Cleaning up... 03:39:43 INFO - Return code: 0 03:39:43 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 03:39:43 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')]} 03:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:43 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')]} 03:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:43 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 0x024FD640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025A4F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x00443F90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x025C5E90>, '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 0x003BA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029C65C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-238', 'USERDOMAIN': 'T-W864-IX-238', '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-238', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-238', '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-238\\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 03:39:43 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 03:39:43 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 03:39:43 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:39:43 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Roaming', 03:39:43 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 03:39:43 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 03:39:43 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 03:39:43 INFO - 'COMPUTERNAME': 'T-W864-IX-238', 03:39:43 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:39:43 INFO - 'DCLOCATION': 'SCL3', 03:39:43 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:39:43 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:39:43 INFO - 'HOMEDRIVE': 'C:', 03:39:43 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 03:39:43 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:39:43 INFO - 'KTS_VERSION': '1.19c', 03:39:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 03:39:43 INFO - 'LOGONSERVER': '\\\\T-W864-IX-238', 03:39:43 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:39:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:43 INFO - 'MOZ_NO_REMOTE': '1', 03:39:43 INFO - 'NO_EM_RESTART': '1', 03:39:43 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:39:43 INFO - 'OS': 'Windows_NT', 03:39:43 INFO - 'OURDRIVE': 'C:', 03:39:43 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', 03:39:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:39:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:39:43 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 03:39:43 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 03:39:43 INFO - 'PROCESSOR_LEVEL': '6', 03:39:43 INFO - 'PROCESSOR_REVISION': '1e05', 03:39:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:39:43 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 03:39:43 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 03:39:43 INFO - 'PROGRAMW6432': 'C:\\Program Files', 03:39:43 INFO - 'PROMPT': '$P$G', 03:39:43 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:39:43 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:39:43 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:39:43 INFO - 'PWD': 'C:\\slave\\test', 03:39:43 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:39:43 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:39:43 INFO - 'SYSTEMDRIVE': 'C:', 03:39:43 INFO - 'SYSTEMROOT': 'C:\\windows', 03:39:43 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:43 INFO - 'TEST1': 'testie', 03:39:43 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:43 INFO - 'USERDOMAIN': 'T-W864-IX-238', 03:39:43 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 03:39:43 INFO - 'USERNAME': 'cltbld', 03:39:43 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-238', 03:39:43 INFO - 'WINDIR': 'C:\\windows', 03:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 03:39:43 INFO - Cleaning up... 03:39:43 INFO - Return code: 0 03:39:43 INFO - Running post-action listener: _resource_record_post_action 03:39:43 INFO - Running post-action listener: _start_resource_monitoring 03:39:43 INFO - Starting resource monitoring. 03:39:43 INFO - [mozharness: 2016-12-02 11:39:43.634000Z] Finished create-virtualenv step (success) 03:39:43 INFO - [mozharness: 2016-12-02 11:39:43.634000Z] Running install step. 03:39:43 INFO - Running pre-action listener: _resource_record_pre_action 03:39:43 INFO - Running main action method: install 03:39:43 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 03:39:43 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 03:39:43 INFO - Reading from file tmpfile_stdout 03:39:43 INFO - Using _rmtree_windows ... 03:39:43 INFO - Using _rmtree_windows ... 03:39:43 INFO - Detecting whether we're running mozinstall >=1.0... 03:39:43 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 03:39:43 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 03:39:44 INFO - Reading from file tmpfile_stdout 03:39:44 INFO - Output received: 03:39:44 INFO - Usage: mozinstall-script.py [options] installer 03:39:44 INFO - Options: 03:39:44 INFO - -h, --help show this help message and exit 03:39:44 INFO - -d DEST, --destination=DEST 03:39:44 INFO - Directory to install application into. [default: 03:39:44 INFO - "C:\slave\test"] 03:39:44 INFO - --app=APP Application being installed. [default: firefox] 03:39:44 INFO - Using _rmtree_windows ... 03:39:44 INFO - Using _rmtree_windows ... 03:39:44 INFO - mkdir: C:\slave\test\build\application 03:39:44 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-53.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 03:39:44 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-53.0a1.en-US.win64.zip --destination C:\slave\test\build\application ProcessManager NOT managing child processes 03:39:46 INFO - Reading from file tmpfile_stdout 03:39:46 INFO - Output received: 03:39:46 INFO - C:\slave\test\build\application\firefox\firefox.exe 03:39:46 INFO - Using _rmtree_windows ... 03:39:46 INFO - Using _rmtree_windows ... 03:39:46 INFO - Running post-action listener: _resource_record_post_action 03:39:46 INFO - [mozharness: 2016-12-02 11:39:46.175000Z] Finished install step (success) 03:39:46 INFO - [mozharness: 2016-12-02 11:39:46.175000Z] Running run-tests step. 03:39:46 INFO - Running pre-action listener: _resource_record_pre_action 03:39:46 INFO - Running main action method: run_tests 03:39:46 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 03:39:46 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 03:39:46 INFO - Python 2.7.3 03:39:46 INFO - Return code: 0 03:39:46 INFO - grabbing minidump binary from tooltool 03:39:46 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')]} 03:39:46 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 0x025C5E90>, '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 0x003BA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x029C65C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 03:39:46 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 03:39:46 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 03:39:46 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 03:39:46 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 03:39:47 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpdyyebi 03:39:47 INFO - INFO - File integrity verified, renaming tmpdyyebi to win32-minidump_stackwalk.exe 03:39:48 INFO - Return code: 0 03:39:48 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 03:39:48 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 03:39:48 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 03:39:48 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 03:39:48 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 03:39:48 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-238', '--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 03:39:48 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Firefox --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-238 --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 03:39:48 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 03:39:48 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Roaming', 03:39:48 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 03:39:48 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 03:39:48 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 03:39:48 INFO - 'COMPUTERNAME': 'T-W864-IX-238', 03:39:48 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 03:39:48 INFO - 'DCLOCATION': 'SCL3', 03:39:48 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 03:39:48 INFO - 'FP_NO_HOST_CHECK': 'NO', 03:39:48 INFO - 'HOMEDRIVE': 'C:', 03:39:48 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-238', 03:39:48 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 03:39:48 INFO - 'KTS_VERSION': '1.19c', 03:39:48 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-238\\AppData\\Local', 03:39:48 INFO - 'LOGONSERVER': '\\\\T-W864-IX-238', 03:39:48 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 03:39:48 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 03:39:48 INFO - 'MONDIR': 'C:\\Monitor_config\\', 03:39:48 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 03:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:48 INFO - 'MOZ_NO_REMOTE': '1', 03:39:48 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 03:39:48 INFO - 'NO_EM_RESTART': '1', 03:39:48 INFO - 'NUMBER_OF_PROCESSORS': '8', 03:39:48 INFO - 'OS': 'Windows_NT', 03:39:48 INFO - 'OURDRIVE': 'C:', 03:39:48 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 03:39:48 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 03:39:48 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 03:39:48 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 03:39:48 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 03:39:48 INFO - 'PROCESSOR_LEVEL': '6', 03:39:48 INFO - 'PROCESSOR_REVISION': '1e05', 03:39:48 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 03:39:48 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 03:39:48 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 03:39:48 INFO - 'PROGRAMW6432': 'C:\\Program Files', 03:39:48 INFO - 'PROMPT': '$P$G', 03:39:48 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 03:39:48 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 03:39:48 INFO - 'PUBLIC': 'C:\\Users\\Public', 03:39:48 INFO - 'PWD': 'C:\\slave\\test', 03:39:48 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 03:39:48 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 03:39:48 INFO - 'SLAVEDIR': 'C:\\slave\\', 03:39:48 INFO - 'SYSTEMDRIVE': 'C:', 03:39:48 INFO - 'SYSTEMROOT': 'C:\\windows', 03:39:48 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:48 INFO - 'TEST1': 'testie', 03:39:48 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 03:39:48 INFO - 'USERDOMAIN': 'T-W864-IX-238', 03:39:48 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-238', 03:39:48 INFO - 'USERNAME': 'cltbld', 03:39:48 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-238', 03:39:48 INFO - 'WINDIR': 'C:\\windows', 03:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 03:39:48 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-238', '--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 03:39:48 INFO - mozversion application_buildid: 20161202013003 03:39:48 INFO - mozversion application_changeset: f65ad27efe839ce9df0283840a1a40b4bbc9ead0 03:39:48 INFO - mozversion application_display_name: Nightly 03:39:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:39:48 INFO - mozversion application_name: Firefox 03:39:48 INFO - mozversion application_remotingname: firefox 03:39:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:39:48 INFO - mozversion application_vendor: Mozilla 03:39:48 INFO - mozversion application_version: 53.0a1 03:39:48 INFO - mozversion platform_buildid: 20161202013003 03:39:48 INFO - mozversion platform_changeset: f65ad27efe839ce9df0283840a1a40b4bbc9ead0 03:39:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:39:48 INFO - mozversion platform_version: 53.0a1 03:39:48 INFO - using testdate: 1480678788 03:39:48 INFO - actual date: 1480678788 03:39:48 INFO - starting webserver on 'localhost:49279' 03:39:48 INFO - SUITE-START | Running 2 tests 03:39:48 INFO - TEST-START | dromaeo_css 03:39:48 INFO - operating with platform_type : w8_ 03:39:48 INFO - Initialising browser for dromaeo_css test... 03:39:48 INFO - TEST-INFO | started process 3032 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpolukgt\profile http://localhost:49279/getInfo.html) 03:39:55 INFO - PROCESS | 3032 | __metrics Screen width/height:1600/1200 03:39:55 INFO - PROCESS | 3032 | colorDepth:24 03:39:55 INFO - PROCESS | 3032 | Browser inner width/height: 1010/674 03:39:55 INFO - PROCESS | 3032 | __metrics 03:39:56 INFO - PROCESS | 3032 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:39:56 INFO - PROCESS | 3032 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:39:58 INFO - TEST-INFO | 3032: exit 0 03:39:58 INFO - Browser initialized. 03:39:58 INFO - Running cycle 1/1 for dromaeo_css test... 03:39:58 INFO - TEST-INFO | started process 1284 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpolukgt\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:58 INFO - PROCESS | 1284 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 03:40:09 INFO - PROCESS | 1284 | RSS: Main: 158916608 03:40:09 INFO - PROCESS | 1284 | 03:41:00 INFO - PROCESS | 1284 | 1480678860538 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] 03:43:11 INFO - PROCESS | 1284 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 03:43:12 INFO - PROCESS | 1284 | RSS: Main: 279142400 03:43:12 INFO - PROCESS | 1284 | 03:46:15 INFO - PROCESS | 1284 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 03:46:16 INFO - PROCESS | 1284 | RSS: Main: 226902016 03:46:16 INFO - PROCESS | 1284 | 03:49:18 INFO - PROCESS | 1284 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 03:49:19 INFO - PROCESS | 1284 | RSS: Main: 187777024 03:49:19 INFO - PROCESS | 1284 | 03:52:21 INFO - PROCESS | 1284 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 03:52:21 INFO - PROCESS | 1284 | RSS: Main: 179400704 03:52:21 INFO - PROCESS | 1284 | 03:55:25 INFO - PROCESS | 1284 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 03:55:25 INFO - PROCESS | 1284 | RSS: Main: 161333248 03:55:25 INFO - PROCESS | 1284 | 03:58:28 INFO - PROCESS | 1284 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 03:58:29 INFO - PROCESS | 1284 | RSS: Main: 334446592 03:58:29 INFO - PROCESS | 1284 | 03:58:29 INFO - PROCESS | 1284 | __start_tp_report 03:58:29 INFO - PROCESS | 1284 | _x_x_mozilla_page_load 03:58:29 INFO - PROCESS | 1284 | _x_x_mozilla_page_load_details 03:58:29 INFO - PROCESS | 1284 | |i|pagename|runs| 03:58:29 INFO - PROCESS | 1284 | |0;dojo.html;2834.929126771831;2848.8860445582177;2864.684884662688;2895.4932886744823;2899.028825343511;5091.898162036761;5162.586993040557;5186.844394668156;5187.610929180308;5232.162853943365;5034.320366750488;5073.3404657394485;5082.23766435034;5084.389873215219;5149;4541.863744087666;4598.287265473857;4612.215923293032;4618.49196588375;4711.7879695413785;4608.239640459337;4619.538046195387;4630.629549636038;4641.489436162019;4689.484156742756;610.4361340013137;4659.976700116495;4680.859574212779;4708.952910470903;4732.05358928214;4505.662075344362;4570.451545814523;4587.770611469413;4603.401557797465;4640.187967105743;4575.839845605421;4607.401037865089;4617.515160908123;4625.982283897571;4651.558101980307;5156.149235376159;5162.664426812283;5176.948230517684;5189.896202075975;5225.033368826779;5403.675779453245;5407.134858422633;5414;5430.5927055471;5432.375276843174;5567.192757050246;5569.359523654791;5578.748956296977;5614.382417934024;5632.605717599769;5110.821121260738;5113.2330150477355;5115.641905066647;5124.795008199705;5167.948320516822;5468.781248750085;5471.671699698031;5540.113581826889;5669.40471250521;5677.403872593401;5343.599230057761;5392.838214853561;5409.350877894678;5421.295231619864;5483.862903427366;5515.338159420895;5544.833654990357;5546.473085056913;5559.972200138974;5569.777208911679;5358.062339090644;5501.229827824108;5525.281713377235;5535.142052981794;5578.776848925998;5345.54562862161;5387.164989426645;5417.431169727122;5476.479734425223;5480.287562616914;3641.708663306929;3645.9270814584092;3654.853805847736;3675.5405574303213;3676.356637588411;3268.117608245808;3283.540304357392;3295.505674148849;3298.043567365485;3328.7004169624365;4956.90086198274;5025.472325405853;5028.5977121830165;5080;5168.198929165986;5419.539339156216;5474.124140137559;5475.123980163155;5480.808171713971;5497.642653227527;5064.164412871834;5070.340855688811;5076.340075790197;5081.364829396325;5086.109930762102;4511.8646440606835;4515.932261016087;4516.187086324428;4516.638668906479;4521.751303678329;5541.362743284493;5581.274434323512;5598.720063996784;5600.551955843523;5603.859903502445;5497.092979658311;5552.972235138798;5568.331800184003;5575.749091290821;5577.74900129487;5607.99056169877;5608.635438696471;5622.493975542221;5670.688112153706;5700.429957004432;5476.644018138808;5477.424870388551;5479.424660410599;5482.0406428875585;5484.177373394023;5264.210368444764;5426.70153141581;5477;5562.638428502134;5621.297337832771;5347.251384806053;5418.593605479526;5424.294841670558;5457.61796674229;5466.070767969534;5365.973170134124;5388.595855310789;5415.1335786274;5415.945840541544;5423.810166644149;5147.150720131136;5206.375234971828;5281.973590132025;5298.470152984671;5343.839684809462;5365.678059316453;5388.757505912322;5404.054290499225;5404.783808647768;5513.696746678971;5362.865928351823;5374.516293533601;5432.782688692566;5434.157705555645;5434.782608695607 03:58:29 INFO - PROCESS | 1284 | |1;ext.html;546.7621584610694;555.1894234417753;569.322506217601;569.7977218087582;570.9914351284732;26919.5962060569;28725.569116463244;28748.28129296766;34885.651143488554;35869;36813;37114.4432833507;37186.628133718725;37288.254234915286;37288.62711372886;7824.804379890491;7925.405594580401;7978.561179135145;7997.6001199940065;7998.760037198865;7178.389836863873;7323.523970941872;8031.397645176606;8135.3491720662505;9471.905280947205;9545.80908381832;9786.755331116743;9800.31397802154;9804.901950980506;9821.558029888673;9500.999999999965;9571.712848614483;9572.95213523935;9623;9626.08552187548;7080.539764915264;7283.963580182118;9180.265578753684;9600.32797704161;9670.468124253162;35252.47121293183;35574.11064723377;35629;35658.465123023176;35668.64331356705;2889.335452845857;2927.2535503446697;3013.367192889496;3034.332446861687;3361.058903507022;28283;28810.711892881012;28845.71154288472;29073;29303.120906372842;3636.4363523653874;3643.344198044351;3660.4692319613773;3674.779513229215;3780.7731536107644;281380;282055;282062;282293;282485.58757206285;46181.76909115433;46495.767521162175;46522.30216546755;46579.5342046582;46592.534074659496;47612.28581571279;47695;47749;47863.28205076927;47889;13499.932500337436;13659.521916732867;13682.110662806886;13705.177689338672;13708.725825483634;10451.68644940653;10470.685879423629;10484.842727359095;10486.73783155412;10540.789184216426;12028.218165819193;12344.691382715504;12357.949574286107;12603.93698031504;12618.621441356774;4697.197173266475;5493.9286839066;5508.7521061552325;5511.448855114457;5527.419620939824;762.3824701991293;821.6836517940636;822.9341652667772;929.6235024814961;948.7485816258697;25626.74373256281;26138.477230455665;26589;26739.46521069568;26806.731932680814;856.4390324337569;866.6923242249037;879.520661239626;904.5477261369315;910.6357457017114;13313.600591982256;13849.338079430532;14057.78913316301;14062.296885155905;14080.647983800487;412977;415686;416537;416539;417154;45906;46023.079538409045;46034.76982615065;46058;46100.3084953726;1109.2235435195396;1125.3697929159696;1133.7222380516662;1134.82977553366;1135.7501349703052;25183.74816251814;25967.61048584235;26234;26407;26545.33636659099;40101.19797603973;40314.59685403226;40351;40390;40465.59534404618;346878;348641;348754;349401;349632;33696;35239.11902202466;35277;35298.29403411969;35307.47038794471;37982.240355193295;38948.221035578565;39003.21993560169;39416.60583394244;39980;33704.66295337113;34469.82765086158;34488.310233794684;34695;35197.296054079285;33406.498902515996;33856.322873542886;33933.77629125229;33978.64085436555;34381.96854094381;32267.193320167185;32698.509522356708;32907.341853163285;33112.1721956953;33131.17172070718;29380.55929161107;30619.846900765355;30622;30732.385352293277;30975.535366969063;23659.462134961173;23692.881535592212;23772.286831395086;23825.285241442783;24031.158909438087 03:58:29 INFO - PROCESS | 1284 | |2;jquery.html;302.0907069720142;308.8841684368362;327.05807275047874;327.83444360597895;328.6975982096471;12605.495780168794;13408.865911340896;16035.518934431957;16428.096454694987;16882.324707011736;14201;14205;14329.355179016944;16148;16331.673366532663;5054.924176137351;5055.898882022358;5222.791088356461;5250.05499010178;5265;5006.123928312549;5139.306193663863;5145.536901678848;5147.897042059157;5149.510796474347;5097.184450487923;5098.082345177885;5100.948990510103;5107.846764597068;5108.770105345268;4918.877028074291;5088.821891233808;5108.208227724708;5114.846554603368;5119.564836988879;4468.664850136252;4493.865184044484;4493.977530112361;4497.2129877271345;4498.3252512123445;18790.248390064382;19648.214071437127;19679.90160049205;19735;19894.90052549728;2000.539875828553;2084.749830020392;2089.4254080127935;2139.144342263092;2213.2917466410754;8561.914380856175;8749.737507874774;8925.107489251088;9052.909470905273;9135.177833994905;1751.2994802079143;1822.772153480815;1848.6210326882956;1848.9537761555935;1850.7131394633852;69381.65309173473;70808.29191708069;71747;74354;75485.24514754837;9309.30180236485;9331.486768227676;9441.055894410503;9555.761105972406;9575.281853860848;12628.747425051448;12654.114212005255;12668.176568523017;12671.683207919876;12730.427130779137;6763.357481039294;6938.56592335577;7000.684969176399;7026.683799229047;7032.648367581703;6641.568298060611;6655.401013908771;6674.399304062657;6785.185777706707;6805.2173999989645;3905.9804700976315;3915.611476999028;3955.011247188203;3968.6704953840785;4067.3695577185586;1593.9043657380594;1620.6758648270156;1633.9591510212101;1636.1164970915572;1636.6644837808221;768.3545821509847;775.5540564175622;788.5387048576532;811.2333844516993;826.3224156191985;15310.387584496495;15695.607609809846;15744.527664170093;15989.262278783242;16174.27215775293;798.4849771897094;800.2317774936126;812.370412929984;815.5808892527078;869.4088020146235;8623.439476434012;8668.826623467496;8871.245944094824;8926.955365223263;9087.545622718837;380701;388245;389463;394357;394903;62195.37804621896;72286;75545.26867260832;82103.58948205221;82398.58800706078;787.8621241282752;795.777182388932;819.9631016604147;820.1265652080515;820.5651004967377;11262.887371126511;13903.791443128159;14416.062955907832;14700.41198352054;14730.852691473377;35380.823095884356;35511.28977420489;35882.28235435329;36107.09732256715;36187;46276.305855412866;47712.5228747722;51072.744636276584;51264;51604.93703727737;6942.687579059056;6966.721331146698;6989;7062.540934839219;7339.9633001834645;10207.285490015627;11245.212835101463;11406.48670809799;11475.770484590095;11501.827472588086;9393.577289021874;9585.7593250222;10060.0945914868;10072;10197.18422526211;9834.360766550151;9865.112139907156;10014.499275036365;10111.140553053074;10273.794524109626;9689.321747477608;10012.749681258027;10192.898071019195;10223.079922806983;10394.324368915995;6887.139107611549;6909.861802763816;6944.826379340355;6991.930080699128;7083.858322833617;9071.228945539702;9518.428894266366;9597.568109434953;9860.753481163028;10140.594376224868 03:58:29 INFO - PROCESS | 1284 | |3;mootools.html;1130.547780887645;1132.462080511757;1194.9163558550902;1376.600785772126;1430.735313966917;6789.966050169754;7142.750003749869;7144.321289477498;7150.141982962039;7152.356287934085;6214.316425193225;6420.935790642092;6796.660166991655;6943.132108486439;6950.687219075141;1838.0717737542523;1864.0679660169915;1867.094459187293;1869.3550724999852;1871.1860340751816;1779.519529726973;1808.990955045223;1813.8548916086747;1819.7088465845402;1820.0899550224888;1643.4576589725423;1699.3457518855269;1818.3363072478583;1858.4982054845184;1871.840893524052;1848.7504186934725;1861.4415675297425;1863.0405341249268;1863.4689113602558;1864.9813501864944;1850.0472256787766;1869.869109162359;1871.3450292397688;1875.681134207188;1877.802830702784;6960.721571137199;7064.04635374223;7069.646517674096;7118.644067796641;7132.358087772125;4244.7240929339805;4325;4360.7819609019425;4373.737575745466;4376.387305777193;2752.587111933206;2876.8849246030136;2918.751906087985;2926.8536573171255;2930.223490774946;913.6391125505388;939.4363381970832;967.6516454076527;968.8062387522524;1826.3333883132693;9595.664151754656;9618.615255389846;9768.51157442125;9772.706818795448;9796.706098817047;3510.8598631359614;3599.892003239907;3613.1870329175727;3664.4320130379833;3671.284099600552;7527.698892044366;7625.428092893055;7632.007838980897;7634.770956871303;7645.350145237606;4256.084941737541;4267.594578515036;4272.252355837716;4280.614744672995;4284;3877.8448862045766;4008.4588580541836;4049.4128351388886;4064.7967601620394;4066.8169932353117;2918.73731364174;2955.7733540580416;2998.1755017370397;3031.272494601324;3033.2113650451042;882.2456799436518;885.7829831691276;890.9777255568533;893.629143905285;898.9325800564984;726.9709211631581;728.3881539506734;736.0615215600046;741.388354607451;764.4992529892929;4316.69783115179;4363.629091527192;4454.554544545519;4470.731756094645;4576.8626941191815;347.7426704238845;350.28017424193524;351.13095089652904;355.4738986300238;357.34427325856825;2921.1090617361483;2968.6289213848268;3000.6699263081046;3001.7898747087493;3018.501947178691;8494.150584941457;8663.133686631287;8753.431026983226;8793.956030219935;8804.031556528776;8743.956280218557;8746.169113934166;8746.86879696805;8758.91241087581;8794.472331660121;6381.202349706286;6650.301718319507;6680.231773346128;6746.123004009545;6761.763338283235;4685.8594242172785;4708.835190768306;4789.521047895182;4797.352357431702;4906.460289368238;8019.959900200462;8099.352051835721;8113.59432028408;8180.713675021346;8190.426670133272;8240.340772738047;8282.834343313221;8305.335573154012;8346;8355.749327520183;6303.527235457451;6344.555881088279;6447.968325068155;6451.838704032249;6455.741770329322;6833.897491537531;6875.518713689994;6904.620245886525;6916;6921.2732663071665;6311.684415779285;6422.715456908543;6453.483721302378;6488.805335839932;6540.574862633914;6236;6282.371762823681;6288.213973253343;6353.237611486466;6358.904616430665;5725.942740572541;5848.298204215351;5850.64896106235;5852.648841069379;5856.12158176277;3892.143728379752;3893.552241492265;3903.0632648164806;3917.294886920268;4086.8773936781945;3866.825992830273;3874.9225015500097;3891.3384724597454;3940.8423663054305;4009.8396064157105 03:58:29 INFO - PROCESS | 1284 | |4;prototype.html;259.07381112522734;275.16213131016053;275.9089500464847;282.14931980080064;285.0522014302445;5001.349824522811;5158.690478571289;5200.37595488541;5234.895302093956;5280.785419353551;4921.852344429664;5169.689818610886;5171.896562068766;5174.611904107188;5177.249298851664;3857.942130868032;3886.5336159660737;3891.474650922132;3902.687784977209;3909.882703518899;3699.8520059197735;3766.8681596144143;3796.0829780960576;3840.923181536368;3846;3826.349520581508;3826.9617303826885;3827.3302172119766;3833.252515759428;3836;3837.2133712588993;3844.50021497205;3848.1534062506203;3857.826397812077;3859.8456061757497;3110.7977981431136;3186.1875221818286;3258.3157536917274;3262.755293352984;3276.7214786743157;4986.476419975923;5020.347354843883;5045.84862454127;5062.417821950486;5072.467390923936;4418.734875907456;4423.402840616508;4423.402840616508;4424.137293227822;4449.399331090293;5269.920951185735;5306.230596563477;5345.946540534584;5374.8925021499745;5391.78432862689;3586.4620306954166;3595.712343012579;3599.5860476045327;3601.873934412283;3606.4770608261656;5576.972115139439;5624.521915637176;5632.802851900164;5636.464535869127;5636.943630563683;3647.708183345326;3705.962940370616;3717.628237176261;3746.1758413149064;3746.83139258734;3773.8301776420126;3790.2040571479747;3794.487744154559;3796;3810.7904065276675;4270.615644592001;4304.48346198452;4398.208322501981;4417.315316126005;4425.756583387944;5394.597404674734;5408.891822163535;5432.59255555827;5456.672599644034;5468.644538105011;1254.5044707340548;1268.397511182181;1270.8729127087402;1270.8919741822049;1271.6630093025356;832.2676045080291;845.691322667222;845.8858054162732;849.674507767884;857.9532969776863;4947.406311242674;4964.627652926045;4979.875503112451;4982.651214415028;4990.4011518618;5361;5431.864203394946;5432.940576587606;5451.454854514596;5453.509184173444;4734.597559207437;4914.582260507826;4971.403431588233;5010.749462526859;5055.241713742968;2886.523723585585;2886.628851295618;2890.59531665567;2898.2174812800426;2900.6084178635615;5466.535344495763;5469.507744303032;5503.422140675251;5519.2824932758485;5522.66863988154;5139.715071232192;5446.673199608036;5475.972620136874;5477.070636427167;5489.917651235235;5467.398586155519;5473.261109750212;5480.205370221216;5494.36814766299;5496.262541471838;5151.175811870083;5223.767060428675;5337.359516858002;5366.255966810724;5405.675609475704;5244.902039184204;5248.402040989735;5271.156614941591;5278.2346559749385;5294.867628309323;5501.752421141138;5502.0371434999515;5510.401983424762;5518.944810551843;5522.735678371848;3549.8402571884844;3658.5061016762397;3658.9451158233182;3668.559772827278;3676.364018011959;5329;5360.785568577369;5374.543163830962;5405.5135037846785;5454;5422.5119739223655;5458.781648734165;5462;5464.672119672832;5476.945230547643;5255.343082114736;5431.945680543144;5458.372287187024;5511.393746687781;5539.8892022160135;5245.134552798745;5392.029434701792;5428.797009764258;5445.646033007842;5447.373552041566;5528.364238112507;5541.584381171348;5545.334559852843;5556.277683901067;5575.073086629552;5449.455054494519;5457.962987032452;5460.3993560707495;5477.260569823023;5498.725063746877 03:58:29 INFO - PROCESS | 1284 | |5;yui.html;593.8159170657096;682.3449488491049;682.7030241844798;690.953205893072;703.0684343245201;13504.797428038588;13719.245441500714;13899;13938.790918136236;14687.192204428766;12519.154453656034;12694.61916142515;12775.61673149807;12775.872241277584;12781.936090319536;498.5446675125013;512.743628185907;517.8498235511706;610.6397225636873;612.0788213738317;601.1493736363063;616.4513582911212;617.6479406738162;619.309469941017;621.1304174156195;642.8457170279123;644.5842431631595;644.65188798049;645.1838424393146;645.2805122288638;537.0360203434824;543.9755211015514;551.7048379117153;642.1202951955827;642.826436862047;398.2254514968388;399.1338794815229;453.34718006071154;454.51367037270137;462.5929182319537;12351.135420520568;12362.690932726753;12366.44351004198;12373;12373.319467429288;11950.641480755592;12216.389180541026;12417.93791031048;12490.937545312307;12536;12352.38238088092;12374;12376.62870113898;12486.562970295996;12764.297963611998;4087.386891966199;4100.528439229467;4109.116539943926;4180.414741936132;4207.64235040022;70177.64911175462;70498.64750676214;71424.2857571428;74500.25499744987;74758.25241747622;9789.706308810748;9862.260330475243;9864.802703946025;9987;10130.138938190335;16751.162441877856;16955.067471289196;17128.229229684694;17160.570985725208;17202.1398930053;7169.103862017248;7244.637768111574;7309.89035164473;7310.378617817545;7321.560706357635;4151.771652559078;4216.810243539048;4230.957690423118;4269.274223382033;4392.868213953522;2709.417475242793;2775.6252905857855;2781.3880946191807;2795.273228960485;2796.398774263543;508.2554058304528;515.2554558662771;521.262413684632;527.4804317747016;531.2217601214239;588.6703446070214;602.403620415794;611.0803241122082;621.6394491195095;623.7130919776954;8296.958515207385;8474.618642161118;8493.108223636553;8501.61742721579;8609.268212202032;569.2363574844155;572.4418691775486;574.0499473371576;590.282806390238;612.6783438694632;3721.6092310307026;3875.302445559826;3908.335582950905;3971.801409929492;4032.5765794591143;60650.69674651687;70374.64812675904;70738.2926170742;70757.64621176964;71683.95189705615;63012;63451;63477;63604.68197658982;63970;48607.75696121638;56602;56819.14771278434;56882.7155864218;57335.959448515445;8947.284217262473;9025;9288.628454862;9401.717948461557;9541.761455963657;36110.819445902605;36140.27719445649;36483.452748209325;37055;39549;46281;47770.76114619405;48357;49804.25293620526;50376;11738.70653233676;11798.823017654913;11925.701857453287;11989.280643161439;12162.756744864877;14330.28348582546;14393.280335983369;14503.419863205354;14531.160592113447;14637.560873173821;11976.640700778991;11988.46051927648;12049.879501204876;12101.515939362327;12318.507259709511;11996.58011969577;12031.338276394883;12047.75904481923;12131.636050918487;12253.509859605516;13031.543895963596;13265.668358290734;13366.331683415985;13521.932390337985;13764.380602872694;10933.175069448114;10964.671059868217;11343.886561134614;11514;12139;10991.230613856953;11132.777344452903;11285.137952237788;11452.3701196435;11510.251833630788 03:58:29 INFO - PROCESS | 1284 | __end_tp_report 03:58:29 INFO - PROCESS | 1284 | __start_cc_report 03:58:29 INFO - PROCESS | 1284 | _x_x_mozilla_cycle_collect,1416 03:58:29 INFO - PROCESS | 1284 | __end_cc_report 03:58:29 INFO - PROCESS | 1284 | __startTimestamp1480679909005__endTimestamp 03:58:29 INFO - PROCESS | 1284 | 03:58:29 INFO - PROCESS | 1284 | ------- Summary: start ------- 03:58:29 INFO - PROCESS | 1284 | Number of tests: 6 03:58:29 INFO - PROCESS | 1284 | 03:58:29 INFO - PROCESS | 1284 | [#0] dojo.html Cycles:165 Average:5027.90 Median:5347.25 stddev:748.30 (14.0%) stddev-sans-first:730.55 03:58:29 INFO - PROCESS | 1284 | Values: 2834.9 2848.9 2864.7 2895.5 2899.0 5091.9 5162.6 5186.8 5187.6 5232.2 5034.3 5073.3 5082.2 5084.4 5149.0 4541.9 4598.3 4612.2 4618.5 4711.8 4608.2 4619.5 4630.6 4641.5 4689.5 610.4 4660.0 4680.9 4709.0 4732.1 4505.7 4570.5 4587.8 4603.4 4640.2 4575.8 4607.4 4617.5 4626.0 4651.6 5156.1 5162.7 5176.9 5189.9 5225.0 5403.7 5407.1 5414.0 5430.6 5432.4 5567.2 5569.4 5578.7 5614.4 5632.6 5110.8 5113.2 5115.6 5124.8 5167.9 5468.8 5471.7 5540.1 5669.4 5677.4 5343.6 5392.8 5409.4 5421.3 5483.9 5515.3 5544.8 5546.5 5560.0 5569.8 5358.1 5501.2 5525.3 5535.1 5578.8 5345.5 5387.2 5417.4 5476.5 5480.3 3641.7 3645.9 3654.9 3675.5 3676.4 3268.1 3283.5 3295.5 3298.0 3328.7 4956.9 5025.5 5028.6 5080.0 5168.2 5419.5 5474.1 5475.1 5480.8 5497.6 5064.2 5070.3 5076.3 5081.4 5086.1 4511.9 4515.9 4516.2 4516.6 4521.8 5541.4 5581.3 5598.7 5600.6 5603.9 5497.1 5553.0 5568.3 5575.7 5577.7 5608.0 5608.6 5622.5 5670.7 5700.4 5476.6 5477.4 5479.4 5482.0 5484.2 5264.2 5426.7 5477.0 5562.6 5621.3 5347.3 5418.6 5424.3 5457.6 5466.1 5366.0 5388.6 5415.1 5415.9 5423.8 5147.2 5206.4 5282.0 5298.5 5343.8 5365.7 5388.8 5404.1 5404.8 5513.7 5362.9 5374.5 5432.8 5434.2 5434.8 03:58:29 INFO - PROCESS | 1284 | 03:58:29 INFO - PROCESS | 1284 | [#1] ext.html Cycles:180 Average:48650.67 Median:35601.56 stddev:93287.37 (262.0%) stddev-sans-first:93479.15 03:58:29 INFO - PROCESS | 1284 | Values: 546.8 555.2 569.3 569.8 571.0 26919.6 28725.6 28748.3 34885.7 35869.0 36813.0 37114.4 37186.6 37288.3 37288.6 7824.8 7925.4 7978.6 7997.6 7998.8 7178.4 7323.5 8031.4 8135.3 9471.9 9545.8 9786.8 9800.3 9804.9 9821.6 9501.0 9571.7 9573.0 9623.0 9626.1 7080.5 7284.0 9180.3 9600.3 9670.5 35252.5 35574.1 35629.0 35658.5 35668.6 2889.3 2927.3 3013.4 3034.3 3361.1 28283.0 28810.7 28845.7 29073.0 29303.1 3636.4 3643.3 3660.5 3674.8 3780.8 281380.0 282055.0 282062.0 282293.0 282485.6 46181.8 46495.8 46522.3 46579.5 46592.5 47612.3 47695.0 47749.0 47863.3 47889.0 13499.9 13659.5 13682.1 13705.2 13708.7 10451.7 10470.7 10484.8 10486.7 10540.8 12028.2 12344.7 12357.9 12603.9 12618.6 4697.2 5493.9 5508.8 5511.4 5527.4 762.4 821.7 822.9 929.6 948.7 25626.7 26138.5 26589.0 26739.5 26806.7 856.4 866.7 879.5 904.5 910.6 13313.6 13849.3 14057.8 14062.3 14080.6 412977.0 415686.0 416537.0 416539.0 417154.0 45906.0 46023.1 46034.8 46058.0 46100.3 1109.2 1125.4 1133.7 1134.8 1135.8 25183.7 25967.6 26234.0 26407.0 26545.3 40101.2 40314.6 40351.0 40390.0 40465.6 346878.0 348641.0 348754.0 349401.0 349632.0 33696.0 35239.1 35277.0 35298.3 35307.5 37982.2 38948.2 39003.2 39416.6 39980.0 33704.7 34469.8 34488.3 34695.0 35197.3 33406.5 33856.3 33933.8 33978.6 34382.0 32267.2 32698.5 32907.3 33112.2 33131.2 29380.6 30619.8 30622.0 30732.4 30975.5 23659.5 23692.9 23772.3 23825.3 24031.2 03:58:29 INFO - PROCESS | 1284 | 03:58:29 INFO - PROCESS | 1284 | [#2] jquery.html Cycles:180 Average:23804.56 Median:5055.41 stddev:64419.77 (1274.3%) stddev-sans-first:64576.31 03:58:29 INFO - PROCESS | 1284 | Values: 302.1 308.9 327.1 327.8 328.7 12605.5 13408.9 16035.5 16428.1 16882.3 14201.0 14205.0 14329.4 16148.0 16331.7 5054.9 5055.9 5222.8 5250.1 5265.0 5006.1 5139.3 5145.5 5147.9 5149.5 5097.2 5098.1 5100.9 5107.8 5108.8 4918.9 5088.8 5108.2 5114.8 5119.6 4468.7 4493.9 4494.0 4497.2 4498.3 18790.2 19648.2 19679.9 19735.0 19894.9 2000.5 2084.7 2089.4 2139.1 2213.3 8561.9 8749.7 8925.1 9052.9 9135.2 1751.3 1822.8 1848.6 1849.0 1850.7 69381.7 70808.3 71747.0 74354.0 75485.2 9309.3 9331.5 9441.1 9555.8 9575.3 12628.7 12654.1 12668.2 12671.7 12730.4 6763.4 6938.6 7000.7 7026.7 7032.6 6641.6 6655.4 6674.4 6785.2 6805.2 3906.0 3915.6 3955.0 3968.7 4067.4 1593.9 1620.7 1634.0 1636.1 1636.7 768.4 775.6 788.5 811.2 826.3 15310.4 15695.6 15744.5 15989.3 16174.3 798.5 800.2 812.4 815.6 869.4 8623.4 8668.8 8871.2 8927.0 9087.5 380701.0 388245.0 389463.0 394357.0 394903.0 62195.4 72286.0 75545.3 82103.6 82398.6 787.9 795.8 820.0 820.1 820.6 11262.9 13903.8 14416.1 14700.4 14730.9 35380.8 35511.3 35882.3 36107.1 36187.0 46276.3 47712.5 51072.7 51264.0 51604.9 6942.7 6966.7 6989.0 7062.5 7340.0 10207.3 11245.2 11406.5 11475.8 11501.8 9393.6 9585.8 10060.1 10072.0 10197.2 9834.4 9865.1 10014.5 10111.1 10273.8 9689.3 10012.7 10192.9 10223.1 10394.3 6887.1 6909.9 6944.8 6991.9 7083.9 9071.2 9518.4 9597.6 9860.8 10140.6 03:58:29 INFO - PROCESS | 1284 | 03:58:29 INFO - PROCESS | 1284 | [#3] mootools.html Cycles:180 Average:4617.20 Median:5316.20 stddev:2651.05 (49.9%) stddev-sans-first:2645.53 03:58:29 INFO - PROCESS | 1284 | Values: 1130.5 1132.5 1194.9 1376.6 1430.7 6790.0 7142.8 7144.3 7150.1 7152.4 6214.3 6420.9 6796.7 6943.1 6950.7 1838.1 1864.1 1867.1 1869.4 1871.2 1779.5 1809.0 1813.9 1819.7 1820.1 1643.5 1699.3 1818.3 1858.5 1871.8 1848.8 1861.4 1863.0 1863.5 1865.0 1850.0 1869.9 1871.3 1875.7 1877.8 6960.7 7064.0 7069.6 7118.6 7132.4 4244.7 4325.0 4360.8 4373.7 4376.4 2752.6 2876.9 2918.8 2926.9 2930.2 913.6 939.4 967.7 968.8 1826.3 9595.7 9618.6 9768.5 9772.7 9796.7 3510.9 3599.9 3613.2 3664.4 3671.3 7527.7 7625.4 7632.0 7634.8 7645.4 4256.1 4267.6 4272.3 4280.6 4284.0 3877.8 4008.5 4049.4 4064.8 4066.8 2918.7 2955.8 2998.2 3031.3 3033.2 882.2 885.8 891.0 893.6 898.9 727.0 728.4 736.1 741.4 764.5 4316.7 4363.6 4454.6 4470.7 4576.9 347.7 350.3 351.1 355.5 357.3 2921.1 2968.6 3000.7 3001.8 3018.5 8494.2 8663.1 8753.4 8794.0 8804.0 8744.0 8746.2 8746.9 8758.9 8794.5 6381.2 6650.3 6680.2 6746.1 6761.8 4685.9 4708.8 4789.5 4797.4 4906.5 8020.0 8099.4 8113.6 8180.7 8190.4 8240.3 8282.8 8305.3 8346.0 8355.7 6303.5 6344.6 6448.0 6451.8 6455.7 6833.9 6875.5 6904.6 6916.0 6921.3 6311.7 6422.7 6453.5 6488.8 6540.6 6236.0 6282.4 6288.2 6353.2 6358.9 5725.9 5848.3 5850.6 5852.6 5856.1 3892.1 3893.6 3903.1 3917.3 4086.9 3866.8 3874.9 3891.3 3940.8 4009.8 03:58:29 INFO - PROCESS | 1284 | 03:58:29 INFO - PROCESS | 1284 | [#4] prototype.html Cycles:180 Average:4433.67 Median:5170.79 stddev:1357.05 (26.2%) stddev-sans-first:1324.19 03:58:29 INFO - PROCESS | 1284 | Values: 259.1 275.2 275.9 282.1 285.1 5001.3 5158.7 5200.4 5234.9 5280.8 4921.9 5169.7 5171.9 5174.6 5177.2 3857.9 3886.5 3891.5 3902.7 3909.9 3699.9 3766.9 3796.1 3840.9 3846.0 3826.3 3827.0 3827.3 3833.3 3836.0 3837.2 3844.5 3848.2 3857.8 3859.8 3110.8 3186.2 3258.3 3262.8 3276.7 4986.5 5020.3 5045.8 5062.4 5072.5 4418.7 4423.4 4423.4 4424.1 4449.4 5269.9 5306.2 5345.9 5374.9 5391.8 3586.5 3595.7 3599.6 3601.9 3606.5 5577.0 5624.5 5632.8 5636.5 5636.9 3647.7 3706.0 3717.6 3746.2 3746.8 3773.8 3790.2 3794.5 3796.0 3810.8 4270.6 4304.5 4398.2 4417.3 4425.8 5394.6 5408.9 5432.6 5456.7 5468.6 1254.5 1268.4 1270.9 1270.9 1271.7 832.3 845.7 845.9 849.7 858.0 4947.4 4964.6 4979.9 4982.7 4990.4 5361.0 5431.9 5432.9 5451.5 5453.5 4734.6 4914.6 4971.4 5010.7 5055.2 2886.5 2886.6 2890.6 2898.2 2900.6 5466.5 5469.5 5503.4 5519.3 5522.7 5139.7 5446.7 5476.0 5477.1 5489.9 5467.4 5473.3 5480.2 5494.4 5496.3 5151.2 5223.8 5337.4 5366.3 5405.7 5244.9 5248.4 5271.2 5278.2 5294.9 5501.8 5502.0 5510.4 5518.9 5522.7 3549.8 3658.5 3658.9 3668.6 3676.4 5329.0 5360.8 5374.5 5405.5 5454.0 5422.5 5458.8 5462.0 5464.7 5476.9 5255.3 5431.9 5458.4 5511.4 5539.9 5245.1 5392.0 5428.8 5445.6 5447.4 5528.4 5541.6 5545.3 5556.3 5575.1 5449.5 5458.0 5460.4 5477.3 5498.7 03:58:29 INFO - PROCESS | 1284 | 03:58:29 INFO - PROCESS | 1284 | [#5] yui.html Cycles:180 Average:15781.14 Median:4250.12 stddev:20057.80 (471.9%) stddev-sans-first:20081.65 03:58:29 INFO - PROCESS | 1284 | Values: 593.8 682.3 682.7 691.0 703.1 13504.8 13719.2 13899.0 13938.8 14687.2 12519.2 12694.6 12775.6 12775.9 12781.9 498.5 512.7 517.8 610.6 612.1 601.1 616.5 617.6 619.3 621.1 642.8 644.6 644.7 645.2 645.3 537.0 544.0 551.7 642.1 642.8 398.2 399.1 453.3 454.5 462.6 12351.1 12362.7 12366.4 12373.0 12373.3 11950.6 12216.4 12417.9 12490.9 12536.0 12352.4 12374.0 12376.6 12486.6 12764.3 4087.4 4100.5 4109.1 4180.4 4207.6 70177.6 70498.6 71424.3 74500.3 74758.3 9789.7 9862.3 9864.8 9987.0 10130.1 16751.2 16955.1 17128.2 17160.6 17202.1 7169.1 7244.6 7309.9 7310.4 7321.6 4151.8 4216.8 4231.0 4269.3 4392.9 2709.4 2775.6 2781.4 2795.3 2796.4 508.3 515.3 521.3 527.5 531.2 588.7 602.4 611.1 621.6 623.7 8297.0 8474.6 8493.1 8501.6 8609.3 569.2 572.4 574.0 590.3 612.7 3721.6 3875.3 3908.3 3971.8 4032.6 60650.7 70374.6 70738.3 70757.6 71684.0 63012.0 63451.0 63477.0 63604.7 63970.0 48607.8 56602.0 56819.1 56882.7 57336.0 8947.3 9025.0 9288.6 9401.7 9541.8 36110.8 36140.3 36483.5 37055.0 39549.0 46281.0 47770.8 48357.0 49804.3 50376.0 11738.7 11798.8 11925.7 11989.3 12162.8 14330.3 14393.3 14503.4 14531.2 14637.6 11976.6 11988.5 12049.9 12101.5 12318.5 11996.6 12031.3 12047.8 12131.6 12253.5 13031.5 13265.7 13366.3 13521.9 13764.4 10933.2 10964.7 11343.9 11514.0 12139.0 10991.2 11132.8 11285.1 11452.4 11510.3 03:58:29 INFO - PROCESS | 1284 | -------- Summary: end -------- 03:58:29 INFO - PROCESS | 1284 | 03:58:29 INFO - TEST-INFO | 1284: exit 0 03:58:30 INFO - TEST-OK | dromaeo_css | took 1121567ms 03:58:30 INFO - TEST-START | kraken 03:58:30 INFO - operating with platform_type : w8_ 03:58:30 INFO - Initialising browser for kraken test... 03:58:30 INFO - TEST-INFO | started process 3472 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmptlrjww\profile http://localhost:49279/getInfo.html) 03:58:35 INFO - PROCESS | 3472 | __metrics Screen width/height:1600/1200 03:58:35 INFO - PROCESS | 3472 | colorDepth:24 03:58:35 INFO - PROCESS | 3472 | Browser inner width/height: 1010/674 03:58:35 INFO - PROCESS | 3472 | __metrics 03:58:36 INFO - PROCESS | 3472 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:58:36 INFO - PROCESS | 3472 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:58:37 INFO - PROCESS | 3472 | console.error: 03:58:37 INFO - PROCESS | 3472 | Message: Error: Connection closed before committing the transaction. 03:58:37 INFO - PROCESS | 3472 | Stack: 03:58:37 INFO - PROCESS | 3472 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:932:23 03:58:37 INFO - PROCESS | 3472 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 03:58:37 INFO - PROCESS | 3472 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 03:58:37 INFO - PROCESS | 3472 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 03:58:37 INFO - PROCESS | 3472 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 03:58:37 INFO - PROCESS | 3472 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 03:58:37 INFO - PROCESS | 3472 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:550:9 03:58:37 INFO - PROCESS | 3472 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 03:58:37 INFO - PROCESS | 3472 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:386:5 03:58:37 INFO - PROCESS | 3472 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 03:58:37 INFO - PROCESS | 3472 | Barrier/this.client.addBlocker/promise13.4% 03:59:34 INFO - TinderboxPrint: I/O read bytes / time
44,344,832 / 341,700 03:59:34 INFO - TinderboxPrint: I/O write bytes / time
408,606,208 / 3,302,220 03:59:34 INFO - TinderboxPrint: CPU idle
8,246.7 (86.6%) 03:59:34 INFO - TinderboxPrint: CPU user
1,230.4 (12.9%) 03:59:34 INFO - install - Wall time: 3s; CPU: 11.0%; Read bytes: 0; Write bytes: 40805376; Read time: 0; Write time: 66370 03:59:34 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 44344832; Write bytes: 313029120; Read time: 341700; Write time: 3197230 03:59:34 INFO - Running post-run listener: _upload_blobber_files 03:59:34 INFO - Blob upload gear active. 03:59:34 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 03:59:34 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 03:59:34 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Firefox', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 03:59:34 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Firefox -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 03:59:35 INFO - (blobuploader) - INFO - Open directory for files ... 03:59:35 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 03:59:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:59:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:36 INFO - (blobuploader) - INFO - Done attempting. 03:59:36 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 03:59:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:59:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:37 INFO - (blobuploader) - INFO - Done attempting. 03:59:37 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 03:59:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:59:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:39 INFO - (blobuploader) - INFO - Done attempting. 03:59:39 INFO - (blobuploader) - INFO - Iteration through files over. 03:59:39 INFO - Return code: 0 03:59:39 INFO - rmtree: C:\slave\test\build\uploaded_files.json 03:59:39 INFO - Using _rmtree_windows ... 03:59:39 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 03:59:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0138998404de8ad1708f5fa879a266b5d34059c7eb8f01230458888e9211c70fda53701e0308ccee7cc31242c8cf4df430caa967cec27a879df5102c56bd140b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e459de7b38116dde12295a10df540f51a37092baf9295198e1f42aebe677735569077366835309d6f7cc2bc1903675d5ca5aa51e354819b021f67ee1c9410134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e39ff03fe07e61fc9bf446e90000f1fbea7806476f93497d13aa851fe92c9a3abe619ae574f3ab9afb8070c5cd3235ef81bb612d92ca52473f7183985b1e04e"} 03:59:39 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 03:59:39 INFO - Writing to file C:\slave\test\properties\blobber_files 03:59:39 INFO - Contents: 03:59:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0138998404de8ad1708f5fa879a266b5d34059c7eb8f01230458888e9211c70fda53701e0308ccee7cc31242c8cf4df430caa967cec27a879df5102c56bd140b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e459de7b38116dde12295a10df540f51a37092baf9295198e1f42aebe677735569077366835309d6f7cc2bc1903675d5ca5aa51e354819b021f67ee1c9410134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e39ff03fe07e61fc9bf446e90000f1fbea7806476f93497d13aa851fe92c9a3abe619ae574f3ab9afb8070c5cd3235ef81bb612d92ca52473f7183985b1e04e"} 03:59:39 INFO - Running post-run listener: copy_logs_to_upload_dir 03:59:39 INFO - Copying logs to upload dir... 03:59:39 INFO - mkdir: C:\slave\test\build\upload\logs 03:59:39 INFO - Copying logs to upload dir... 03:59:39 INFO - Using _rmtree_windows ... 03:59:39 INFO - Using _rmtree_windows ... 03:59:39 INFO - Using _rmtree_windows ... 03:59:39 INFO - Using _rmtree_windows ... 03:59:39 INFO - Using _rmtree_windows ... 03:59:39 INFO - Using _rmtree_windows ... 03:59:39 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1367.837000 ========= master_lag: 0.04 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 47 secs) (at 2016-12-02 03:59:39.468473) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 03:59:39.474846) ========= '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-238\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-238 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-238 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-238\AppData\Local LOGONSERVER=\\T-W864-IX-238 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-238 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-238 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-238 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0138998404de8ad1708f5fa879a266b5d34059c7eb8f01230458888e9211c70fda53701e0308ccee7cc31242c8cf4df430caa967cec27a879df5102c56bd140b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e459de7b38116dde12295a10df540f51a37092baf9295198e1f42aebe677735569077366835309d6f7cc2bc1903675d5ca5aa51e354819b021f67ee1c9410134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e39ff03fe07e61fc9bf446e90000f1fbea7806476f93497d13aa851fe92c9a3abe619ae574f3ab9afb8070c5cd3235ef81bb612d92ca52473f7183985b1e04e"} build_url:https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/VCNFuBzkTPGYFzgiYmRnww/artifacts/public/build/firefox-53.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0138998404de8ad1708f5fa879a266b5d34059c7eb8f01230458888e9211c70fda53701e0308ccee7cc31242c8cf4df430caa967cec27a879df5102c56bd140b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e459de7b38116dde12295a10df540f51a37092baf9295198e1f42aebe677735569077366835309d6f7cc2bc1903675d5ca5aa51e354819b021f67ee1c9410134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e39ff03fe07e61fc9bf446e90000f1fbea7806476f93497d13aa851fe92c9a3abe619ae574f3ab9afb8070c5cd3235ef81bb612d92ca52473f7183985b1e04e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 03:59:39.599205) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 03:59:39.599547) ========= '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-238\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-238 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-238 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-238\AppData\Local LOGONSERVER=\\T-W864-IX-238 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-238 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-238 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-238 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 03:59:39.721955) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-12-02 03:59:39.722266) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-12-02 03:59:40.552184) ========= ========= Total master_lag: 0.90 =========