builder: autoland_win7_ix_test-dromaeojs-e10s-pgo slave: t-w732-ix-009 starttime: 1475046035.29 results: success (0) buildid: 20160927213033 builduid: 565d41483b1d4e5f98d3ab1a38fa0546 revision: 67109e311e4c1e899eea01a5568af882ba9decc9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 00:00:35.289990) ========= master: http://buildbot-master126.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 00:00:35.290529) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 00:00:35.290849) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 00:00:35.421738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-28 00:00:35.422029) ========= '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\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-009 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-009 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-009 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False --00:00:37-- 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,141 (12K) [text/x-python] 0K .......... . 100% 24.51 MB/s 00:00:37 (24.51 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=2.370000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-28 00:00:37.815803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2016-09-28 00:00:37.816121) ========= '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\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-009 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-009 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-009 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=10.102000 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2016-09-28 00:00:47.927237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 00:00:47.927596) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/autoland --rev 67109e311e4c1e899eea01a5568af882ba9decc9 --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 67109e311e4c1e899eea01a5568af882ba9decc9 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-009 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-009 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-009 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False 2016-09-28 00:00:48,265 truncating revision to first 12 chars 2016-09-28 00:00:48,266 Setting DEBUG logging. 2016-09-28 00:00:48,266 attempt 1/10 2016-09-28 00:00:48,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/67109e311e4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 00:00:48,779 unpacking tar archive at: autoland-67109e311e4c/testing/mozharness/ 2016-09-28 00:00:48,927 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.227000 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 00:00:49.201729) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 00:00:49.202054) ========= script_repo_revision: 67109e311e4c1e899eea01a5568af882ba9decc9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 00:00:49.202479) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 00:00:49.202804) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 00:00:49.212420) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 15 secs) (at 2016-09-28 00:00:49.212820) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs-e10s' '--add-option' '--webServer,localhost' '--branch-name' 'Autoland' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Autoland' in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-009 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-009 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-009 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False 00:00:49 INFO - MultiFileLogger online at 20160928 00:00:49 in C:\slave\test 00:00:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 00:00:49 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 00:00:49 INFO - {'append_to_log': False, 00:00:49 INFO - 'base_work_dir': 'C:\\slave\\test', 00:00:49 INFO - 'blob_upload_branch': 'Autoland', 00:00:49 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 00:00:49 INFO - 'branch': 'Autoland', 00:00:49 INFO - 'buildbot_json_path': 'buildprops.json', 00:00:49 INFO - 'config_files': ('talos/windows_config.py',), 00:00:49 INFO - 'default_actions': ('clobber', 00:00:49 INFO - 'read-buildbot-config', 00:00:49 INFO - 'download-and-extract', 00:00:49 INFO - 'populate-webroot', 00:00:49 INFO - 'create-virtualenv', 00:00:49 INFO - 'install', 00:00:49 INFO - 'run-tests'), 00:00:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:00:49 INFO - 'download_minidump_stackwalk': True, 00:00:49 INFO - 'download_symbols': 'ondemand', 00:00:49 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 00:00:49 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 00:00:49 INFO - 'hg': 'c:/mozilla-build/hg/hg', 00:00:49 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 00:00:49 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 00:00:49 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 00:00:49 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 00:00:49 INFO - 'C:/mozilla-build/tooltool.py'), 00:00:49 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 00:00:49 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 00:00:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:00:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:00:49 INFO - 'installer_path': 'installer.exe', 00:00:49 INFO - 'log_level': 'info', 00:00:49 INFO - 'log_name': 'talos', 00:00:49 INFO - 'log_to_console': True, 00:00:49 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 00:00:49 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 00:00:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 00:00:49 INFO - 'opt_config_files': (), 00:00:49 INFO - 'pip_index': False, 00:00:49 INFO - 'sps_profile': False, 00:00:49 INFO - 'sps_profile_interval': 0, 00:00:49 INFO - 'suite': 'dromaeojs-e10s', 00:00:49 INFO - 'system_bits': '32', 00:00:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:00:49 INFO - 'title': 'T-W732-IX-009', 00:00:49 INFO - 'use_talos_json': True, 00:00:49 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 00:00:49 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 00:00:49 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 00:00:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:00:49 INFO - 'work_dir': 'build'} 00:00:49 INFO - [mozharness: 2016-09-28 07:00:49.846000Z] Running clobber step. 00:00:49 INFO - Running pre-action listener: _resource_record_pre_action 00:00:49 INFO - Running main action method: clobber 00:00:49 INFO - rmtree: C:\slave\test\build 00:00:49 INFO - Using _rmtree_windows ... 00:00:49 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 00:02:29 INFO - Running post-action listener: _resource_record_post_action 00:02:29 INFO - [mozharness: 2016-09-28 07:02:29.420000Z] Finished clobber step (success) 00:02:29 INFO - [mozharness: 2016-09-28 07:02:29.420000Z] Running read-buildbot-config step. 00:02:29 INFO - Running pre-action listener: _resource_record_pre_action 00:02:29 INFO - Running main action method: read_buildbot_config 00:02:29 INFO - Using buildbot properties: 00:02:29 INFO - { 00:02:29 INFO - "project": "", 00:02:29 INFO - "product": "firefox", 00:02:29 INFO - "script_repo_revision": "production", 00:02:29 INFO - "builddir": "autoland_win7_ix_test-dromaeojs-e10s", 00:02:29 INFO - "repository": "", 00:02:29 INFO - "buildername": "Windows 7 32-bit autoland pgo talos dromaeojs-e10s", 00:02:29 INFO - "buildid": "20160927213033", 00:02:29 INFO - "pgo_build": "True", 00:02:29 INFO - "basedir": "C:\\slave\\test", 00:02:29 INFO - "buildnumber": 148, 00:02:29 INFO - "slavename": "t-w732-ix-009", 00:02:29 INFO - "master": "http://buildbot-master126.bb.releng.scl3.mozilla.com:8201/", 00:02:29 INFO - "platform": "win7_ix", 00:02:29 INFO - "scheduler": "tests-autoland-win32-pgo-talos", 00:02:29 INFO - "branch": "autoland", 00:02:29 INFO - "repo_path": "integration/autoland", 00:02:29 INFO - "revision": "67109e311e4c1e899eea01a5568af882ba9decc9", 00:02:29 INFO - "stage_platform": "win32-pgo", 00:02:29 INFO - "builduid": "565d41483b1d4e5f98d3ab1a38fa0546", 00:02:29 INFO - "slavebuilddir": "test" 00:02:29 INFO - } 00:02:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip. 00:02:29 INFO - Running post-action listener: _resource_record_post_action 00:02:29 INFO - [mozharness: 2016-09-28 07:02:29.423000Z] Finished read-buildbot-config step (success) 00:02:29 INFO - [mozharness: 2016-09-28 07:02:29.424000Z] Running download-and-extract step. 00:02:29 INFO - Running pre-action listener: _resource_record_pre_action 00:02:29 INFO - Running main action method: download_and_extract 00:02:29 INFO - mkdir: C:\slave\test\build\tests 00:02:29 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')]} 00:02:29 INFO - trying https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.test_packages.json 00:02:29 INFO - Downloading https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.test_packages.json to C:\slave\test\build\firefox-52.0a1.en-US.win32.test_packages.json 00:02:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win32.test_packages.json'}, attempt #1 00:02:30 INFO - Downloaded 1218 bytes. 00:02:30 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win32.test_packages.json 00:02:30 INFO - Using the following test package requirements: 00:02:30 INFO - {u'common': [u'firefox-52.0a1.en-US.win32.common.tests.zip'], 00:02:30 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win32.common.tests.zip', 00:02:30 INFO - u'firefox-52.0a1.en-US.win32.cppunittest.tests.zip'], 00:02:30 INFO - u'gtest': [u'firefox-52.0a1.en-US.win32.common.tests.zip'], 00:02:30 INFO - u'jittest': [u'firefox-52.0a1.en-US.win32.common.tests.zip', 00:02:30 INFO - u'jsshell-win32.zip'], 00:02:30 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win32.common.tests.zip', 00:02:30 INFO - u'firefox-52.0a1.en-US.win32.mochitest.tests.zip'], 00:02:30 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win32.common.tests.zip'], 00:02:30 INFO - u'reftest': [u'firefox-52.0a1.en-US.win32.common.tests.zip', 00:02:30 INFO - u'firefox-52.0a1.en-US.win32.reftest.tests.zip'], 00:02:30 INFO - u'talos': [u'firefox-52.0a1.en-US.win32.common.tests.zip', 00:02:30 INFO - u'firefox-52.0a1.en-US.win32.talos.tests.zip'], 00:02:30 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win32.common.tests.zip', 00:02:30 INFO - u'firefox-52.0a1.en-US.win32.web-platform.tests.zip'], 00:02:30 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win32.common.tests.zip', 00:02:30 INFO - u'firefox-52.0a1.en-US.win32.xpcshell.tests.zip']} 00:02:30 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win32.common.tests.zip'] for test suite category: common 00:02:30 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip 00:02:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip'}, attempt #1 00:02:30 INFO - Fetch https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip into memory 00:02:31 INFO - Expected file size: 17323102 00:02:31 INFO - Content-Encoding None 00:02:31 INFO - Content-Type application/zip 00:02:31 INFO - Http code 200 00:02:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win32.common.tests.zip', u'firefox-52.0a1.en-US.win32.talos.tests.zip'] for test suite category: talos 00:02:55 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip 00:02:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip'}, attempt #1 00:02:55 INFO - Fetch https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip into memory 00:02:55 INFO - Expected file size: 17323102 00:02:55 INFO - Content-Encoding None 00:02:55 INFO - Content-Type application/zip 00:02:55 INFO - Http code 200 00:03:07 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.talos.tests.zip 00:03:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.talos.tests.zip'}, attempt #1 00:03:07 INFO - Fetch https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.talos.tests.zip into memory 00:03:07 INFO - Expected file size: 14414057 00:03:07 INFO - Content-Encoding None 00:03:07 INFO - Content-Type application/zip 00:03:07 INFO - Http code 200 00:03: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')]} 00:03:18 INFO - trying https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip 00:03:18 INFO - Downloading https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip to C:\slave\test\build\firefox-52.0a1.en-US.win32.zip 00:03:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win32.zip'}, attempt #1 00:03:22 INFO - Downloaded 54816536 bytes. 00:03:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip 00:03:22 INFO - mkdir: C:\slave\test\properties 00:03:22 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 00:03:22 INFO - Writing to file C:\slave\test\properties\build_url 00:03:22 INFO - Contents: 00:03:22 INFO - build_url:https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip 00:03:22 INFO - Running post-action listener: _resource_record_post_action 00:03:22 INFO - Running post-action listener: set_extra_try_arguments 00:03:22 INFO - [mozharness: 2016-09-28 07:03:22.647000Z] Finished download-and-extract step (success) 00:03:22 INFO - [mozharness: 2016-09-28 07:03:22.647000Z] Running populate-webroot step. 00:03:22 INFO - Running pre-action listener: _resource_record_pre_action 00:03:22 INFO - Running main action method: populate_webroot 00:03:22 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 00:03:22 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 00:03:22 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 00:03:22 INFO - u'--tppagecycles', 00:03:22 INFO - u'7'], 00:03:22 INFO - u'tests': [u'tsvgm']}}, 00:03:22 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 00:03:22 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 00:03:22 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 00:03:22 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 00:03:22 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 00:03:22 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 00:03:22 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:22 INFO - u'talos_options': [u'--disable-e10s'], 00:03:22 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 00:03:22 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:22 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 00:03:22 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:22 INFO - u'talos_options': [u'--disable-e10s'], 00:03:22 INFO - u'tests': [u'damp', u'tps']}, 00:03:22 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:22 INFO - u'tests': [u'damp', u'tps']}, 00:03:22 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 00:03:22 INFO - u'tests': [u'dromaeo_dom']}, 00:03:22 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 00:03:22 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 00:03:22 INFO - u'tests': [u'basic_compositor_video']}, 00:03:22 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 00:03:22 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 00:03:22 INFO - u'tests': [u'a11yr', 00:03:22 INFO - u'ts_paint', 00:03:22 INFO - u'tpaint', 00:03:22 INFO - u'sessionrestore', 00:03:22 INFO - u'sessionrestore_no_auto_restore', 00:03:22 INFO - u'tabpaint']}, 00:03:22 INFO - u'other-e10s': {u'tests': [u'a11yr', 00:03:22 INFO - u'ts_paint', 00:03:22 INFO - u'tpaint', 00:03:22 INFO - u'sessionrestore', 00:03:22 INFO - u'sessionrestore_no_auto_restore', 00:03:22 INFO - u'tabpaint']}, 00:03:22 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 00:03:22 INFO - u'ts_paint', 00:03:22 INFO - u'tpaint', 00:03:22 INFO - u'sessionrestore', 00:03:22 INFO - u'sessionrestore_no_auto_restore', 00:03:22 INFO - u'tabpaint']}, 00:03:22 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 00:03:22 INFO - u'ts_paint', 00:03:22 INFO - u'tpaint', 00:03:22 INFO - u'sessionrestore', 00:03:22 INFO - u'sessionrestore_no_auto_restore', 00:03:22 INFO - u'tabpaint']}, 00:03:22 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 00:03:22 INFO - u'tests': [u'a11yr', 00:03:22 INFO - u'ts_paint', 00:03:22 INFO - u'tpaint', 00:03:22 INFO - u'sessionrestore', 00:03:22 INFO - u'sessionrestore_no_auto_restore', 00:03:22 INFO - u'tabpaint']}, 00:03:22 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 00:03:22 INFO - u'tests': [u'a11yr', 00:03:22 INFO - u'ts_paint', 00:03:22 INFO - u'tpaint', 00:03:22 INFO - u'sessionrestore', 00:03:22 INFO - u'sessionrestore_no_auto_restore', 00:03:22 INFO - u'tabpaint']}, 00:03:22 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 00:03:22 INFO - u'tests': [u'tsvgx', 00:03:22 INFO - u'tsvgr_opacity', 00:03:22 INFO - u'tart', 00:03:22 INFO - u'tscrollx', 00:03:22 INFO - u'cart']}, 00:03:22 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 00:03:22 INFO - u'tsvgr_opacity', 00:03:22 INFO - u'tart', 00:03:22 INFO - u'tscrollx', 00:03:22 INFO - u'cart']}, 00:03:22 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:22 INFO - u'talos_options': [u'--disable-e10s'], 00:03:22 INFO - u'tests': [u'tp5o']}, 00:03:22 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:22 INFO - u'tests': [u'tp5o']}, 00:03:22 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:22 INFO - u'talos_options': [u'--disable-e10s', 00:03:22 INFO - u'--xperf_path', 00:03:22 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:03:22 INFO - u'tests': [u'tp5n']}, 00:03:22 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:22 INFO - u'talos_options': [u'--xperf_path', 00:03:22 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:03:22 INFO - u'tests': [u'tp5n']}}, 00:03:22 INFO - u'talos.zip': {u'path': u'', 00:03:22 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:03:22 INFO - Running post-action listener: _resource_record_post_action 00:03:22 INFO - [mozharness: 2016-09-28 07:03:22.711000Z] Finished populate-webroot step (success) 00:03:22 INFO - [mozharness: 2016-09-28 07:03:22.711000Z] Running create-virtualenv step. 00:03:22 INFO - Running pre-action listener: _resource_record_pre_action 00:03:22 INFO - Running main action method: create_virtualenv 00:03:22 INFO - Creating virtualenv C:\slave\test\build/venv 00:03:22 INFO - mkdir: C:\slave\test\build\venv\Scripts 00:03:22 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 00:03:22 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'! 00:03:22 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 00:03:22 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 00:03:25 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 00:03:29 INFO - Installing distribute......................................................................................................................................................................................done. 00:03:30 INFO - Return code: 0 00:03:30 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 00:03:30 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 00:03:31 INFO - Reading from file tmpfile_stdout 00:03:31 INFO - Output received: 00:03:31 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 00:03:31 INFO - Using _rmtree_windows ... 00:03:31 INFO - Using _rmtree_windows ... 00:03:31 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 00:03:31 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')]} 00:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:31 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')]} 00:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:31 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 0x0188F640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01936E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136C410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FF8520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-009', 'USERDOMAIN': 'T-W732-IX-009', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-009', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 00:03:31 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 00:03:31 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 00:03:31 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 00:03:31 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 00:03:31 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 00:03:31 INFO - 'COMPUTERNAME': 'T-W732-IX-009', 00:03:31 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 00:03:31 INFO - 'CYGWINBASE': 'C:\\cygwin', 00:03:31 INFO - 'DCLOCATION': 'SCL3', 00:03:31 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 00:03:31 INFO - 'FP_NO_HOST_CHECK': 'NO', 00:03:31 INFO - 'HOMEDRIVE': 'C:', 00:03:31 INFO - 'HOMEPATH': '\\Users\\cltbld', 00:03:31 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 00:03:31 INFO - 'KTS_VERSION': '1.19c', 00:03:31 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 00:03:31 INFO - 'LOGONSERVER': '\\\\T-W732-IX-009', 00:03:31 INFO - 'MONDIR': 'C:\\Monitor_config\\', 00:03:31 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 00:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:31 INFO - 'MOZ_NO_REMOTE': '1', 00:03:31 INFO - 'NO_EM_RESTART': '1', 00:03:31 INFO - 'NUMBER_OF_PROCESSORS': '8', 00:03:31 INFO - 'OS': 'Windows_NT', 00:03:31 INFO - 'OURDRIVE': 'C:', 00:03:31 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 00:03:31 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 00:03:31 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 00:03:31 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 00:03:31 INFO - 'PROCESSOR_LEVEL': '6', 00:03:31 INFO - 'PROCESSOR_REVISION': '1e05', 00:03:31 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 00:03:31 INFO - 'PROGRAMFILES': 'C:\\Program Files', 00:03:31 INFO - 'PROMPT': '$P$G', 00:03:31 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 00:03:31 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 00:03:31 INFO - 'PUBLIC': 'C:\\Users\\Public', 00:03:31 INFO - 'PWD': 'C:\\slave\\test', 00:03:31 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 00:03:31 INFO - 'SLAVEDIR': 'C:\\slave\\', 00:03:31 INFO - 'SYSTEMDRIVE': 'C:', 00:03:31 INFO - 'SYSTEMROOT': 'C:\\windows', 00:03:31 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:31 INFO - 'TEST1': 'testie', 00:03:31 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:31 INFO - 'USERDOMAIN': 'T-W732-IX-009', 00:03:31 INFO - 'USERNAME': 'cltbld', 00:03:31 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 00:03:31 INFO - 'WINDIR': 'C:\\windows', 00:03:31 INFO - 'WINDOWS_TRACING_FLAGS': '3', 00:03:31 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 00:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 00:03:32 INFO - Ignoring indexes: http://pypi.python.org/simple/ 00:03:32 INFO - Downloading/unpacking pip>=1.5 00:03:36 INFO - Running setup.py egg_info for package pip 00:03:36 INFO - warning: no files found matching 'pip\cacert.pem' 00:03:36 INFO - warning: no files found matching '*.html' under directory 'docs' 00:03:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 00:03:36 INFO - no previously-included directories found matching 'docs\_build\_sources' 00:03:36 INFO - Installing collected packages: pip 00:03:36 INFO - Found existing installation: pip 0.8.2 00:03:36 INFO - Uninstalling pip: 00:03:36 INFO - Successfully uninstalled pip 00:03:36 INFO - Running setup.py install for pip 00:03:36 INFO - warning: no files found matching 'pip\cacert.pem' 00:03:36 INFO - warning: no files found matching '*.html' under directory 'docs' 00:03:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 00:03:36 INFO - no previously-included directories found matching 'docs\_build\_sources' 00:03:36 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 00:03:36 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 00:03:36 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 00:03:36 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 00:03:36 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 00:03:36 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 00:03:36 INFO - Successfully installed pip 00:03:36 INFO - Cleaning up... 00:03:36 INFO - Return code: 0 00:03:36 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 00:03:36 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')]} 00:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:36 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')]} 00:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:36 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 0x0188F640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01936E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136C410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FF8520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-009', 'USERDOMAIN': 'T-W732-IX-009', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-009', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 00:03:37 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 00:03:37 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 00:03:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 00:03:37 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 00:03:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 00:03:37 INFO - 'COMPUTERNAME': 'T-W732-IX-009', 00:03:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 00:03:37 INFO - 'CYGWINBASE': 'C:\\cygwin', 00:03:37 INFO - 'DCLOCATION': 'SCL3', 00:03:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 00:03:37 INFO - 'FP_NO_HOST_CHECK': 'NO', 00:03:37 INFO - 'HOMEDRIVE': 'C:', 00:03:37 INFO - 'HOMEPATH': '\\Users\\cltbld', 00:03:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 00:03:37 INFO - 'KTS_VERSION': '1.19c', 00:03:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 00:03:37 INFO - 'LOGONSERVER': '\\\\T-W732-IX-009', 00:03:37 INFO - 'MONDIR': 'C:\\Monitor_config\\', 00:03:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 00:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:37 INFO - 'MOZ_NO_REMOTE': '1', 00:03:37 INFO - 'NO_EM_RESTART': '1', 00:03:37 INFO - 'NUMBER_OF_PROCESSORS': '8', 00:03:37 INFO - 'OS': 'Windows_NT', 00:03:37 INFO - 'OURDRIVE': 'C:', 00:03:37 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 00:03:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 00:03:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 00:03:37 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 00:03:37 INFO - 'PROCESSOR_LEVEL': '6', 00:03:37 INFO - 'PROCESSOR_REVISION': '1e05', 00:03:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 00:03:37 INFO - 'PROGRAMFILES': 'C:\\Program Files', 00:03:37 INFO - 'PROMPT': '$P$G', 00:03:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 00:03:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 00:03:37 INFO - 'PUBLIC': 'C:\\Users\\Public', 00:03:37 INFO - 'PWD': 'C:\\slave\\test', 00:03:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 00:03:37 INFO - 'SLAVEDIR': 'C:\\slave\\', 00:03:37 INFO - 'SYSTEMDRIVE': 'C:', 00:03:37 INFO - 'SYSTEMROOT': 'C:\\windows', 00:03:37 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:37 INFO - 'TEST1': 'testie', 00:03:37 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:37 INFO - 'USERDOMAIN': 'T-W732-IX-009', 00:03:37 INFO - 'USERNAME': 'cltbld', 00:03:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 00:03:37 INFO - 'WINDIR': 'C:\\windows', 00:03:37 INFO - 'WINDOWS_TRACING_FLAGS': '3', 00:03:37 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 00:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 00:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:38 INFO - Downloading/unpacking psutil>=3.1.1 00:03: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 00:03: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 00:03:39 INFO - Installing collected packages: psutil 00:03:40 INFO - Successfully installed psutil 00:03:40 INFO - Cleaning up... 00:03:40 INFO - Return code: 0 00:03:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 00:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:40 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0188F640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01936E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136C410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FF8520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-009', 'USERDOMAIN': 'T-W732-IX-009', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-009', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 00:03:40 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build 00:03:40 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:03:40 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 00:03:40 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 00:03:40 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 00:03:40 INFO - 'COMPUTERNAME': 'T-W732-IX-009', 00:03:40 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 00:03:40 INFO - 'CYGWINBASE': 'C:\\cygwin', 00:03:40 INFO - 'DCLOCATION': 'SCL3', 00:03:40 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 00:03:40 INFO - 'FP_NO_HOST_CHECK': 'NO', 00:03:40 INFO - 'HOMEDRIVE': 'C:', 00:03:40 INFO - 'HOMEPATH': '\\Users\\cltbld', 00:03:40 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 00:03:40 INFO - 'KTS_VERSION': '1.19c', 00:03:40 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 00:03:40 INFO - 'LOGONSERVER': '\\\\T-W732-IX-009', 00:03:40 INFO - 'MONDIR': 'C:\\Monitor_config\\', 00:03:40 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 00:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:40 INFO - 'MOZ_NO_REMOTE': '1', 00:03:40 INFO - 'NO_EM_RESTART': '1', 00:03:40 INFO - 'NUMBER_OF_PROCESSORS': '8', 00:03:40 INFO - 'OS': 'Windows_NT', 00:03:40 INFO - 'OURDRIVE': 'C:', 00:03:40 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 00:03:40 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 00:03:40 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 00:03:40 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 00:03:40 INFO - 'PROCESSOR_LEVEL': '6', 00:03:40 INFO - 'PROCESSOR_REVISION': '1e05', 00:03:40 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 00:03:40 INFO - 'PROGRAMFILES': 'C:\\Program Files', 00:03:40 INFO - 'PROMPT': '$P$G', 00:03:40 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 00:03:40 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 00:03:40 INFO - 'PUBLIC': 'C:\\Users\\Public', 00:03:40 INFO - 'PWD': 'C:\\slave\\test', 00:03:40 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 00:03:40 INFO - 'SLAVEDIR': 'C:\\slave\\', 00:03:40 INFO - 'SYSTEMDRIVE': 'C:', 00:03:40 INFO - 'SYSTEMROOT': 'C:\\windows', 00:03:40 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:40 INFO - 'TEST1': 'testie', 00:03:40 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:40 INFO - 'USERDOMAIN': 'T-W732-IX-009', 00:03:40 INFO - 'USERNAME': 'cltbld', 00:03:40 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 00:03:40 INFO - 'WINDIR': 'C:\\windows', 00:03:40 INFO - 'WINDOWS_TRACING_FLAGS': '3', 00:03:40 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 00:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 00:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:03:41 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 00:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.3) 00:03:41 INFO - Installing collected packages: mozsystemmonitor 00:03:41 INFO - Running setup.py install for mozsystemmonitor 00:03:41 INFO - Successfully installed mozsystemmonitor 00:03:41 INFO - Cleaning up... 00:03:41 INFO - Return code: 0 00:03:42 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 00:03: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')]} 00:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03: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')]} 00:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:42 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 0x0188F640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01936E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136C410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FF8520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-009', 'USERDOMAIN': 'T-W732-IX-009', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-009', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 00:03:42 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 00:03:42 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 00:03:42 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 00:03:42 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 00:03:42 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 00:03:42 INFO - 'COMPUTERNAME': 'T-W732-IX-009', 00:03:42 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 00:03:42 INFO - 'CYGWINBASE': 'C:\\cygwin', 00:03:42 INFO - 'DCLOCATION': 'SCL3', 00:03:42 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 00:03:42 INFO - 'FP_NO_HOST_CHECK': 'NO', 00:03:42 INFO - 'HOMEDRIVE': 'C:', 00:03:42 INFO - 'HOMEPATH': '\\Users\\cltbld', 00:03:42 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 00:03:42 INFO - 'KTS_VERSION': '1.19c', 00:03:42 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 00:03:42 INFO - 'LOGONSERVER': '\\\\T-W732-IX-009', 00:03:42 INFO - 'MONDIR': 'C:\\Monitor_config\\', 00:03:42 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 00:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:42 INFO - 'MOZ_NO_REMOTE': '1', 00:03:42 INFO - 'NO_EM_RESTART': '1', 00:03:42 INFO - 'NUMBER_OF_PROCESSORS': '8', 00:03:42 INFO - 'OS': 'Windows_NT', 00:03:42 INFO - 'OURDRIVE': 'C:', 00:03:42 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 00:03:42 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 00:03:42 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 00:03:42 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 00:03:42 INFO - 'PROCESSOR_LEVEL': '6', 00:03:42 INFO - 'PROCESSOR_REVISION': '1e05', 00:03:42 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 00:03:42 INFO - 'PROGRAMFILES': 'C:\\Program Files', 00:03:42 INFO - 'PROMPT': '$P$G', 00:03:42 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 00:03:42 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 00:03:42 INFO - 'PUBLIC': 'C:\\Users\\Public', 00:03:42 INFO - 'PWD': 'C:\\slave\\test', 00:03:42 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 00:03:42 INFO - 'SLAVEDIR': 'C:\\slave\\', 00:03:42 INFO - 'SYSTEMDRIVE': 'C:', 00:03:42 INFO - 'SYSTEMROOT': 'C:\\windows', 00:03:42 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:42 INFO - 'TEST1': 'testie', 00:03:42 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:42 INFO - 'USERDOMAIN': 'T-W732-IX-009', 00:03:42 INFO - 'USERNAME': 'cltbld', 00:03:42 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 00:03:42 INFO - 'WINDIR': 'C:\\windows', 00:03:42 INFO - 'WINDOWS_TRACING_FLAGS': '3', 00:03:42 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 00:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 00:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:42 INFO - Downloading/unpacking jsonschema==2.5.1 00:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:03:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:43 INFO - Downloading functools32-3.2.3-2.tar.gz 00:03:43 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 00:03:43 INFO - warning: no files found matching '*.txt' 00:03:43 INFO - no previously-included directories found matching 'build' 00:03:43 INFO - no previously-included directories found matching 'dist' 00:03:43 INFO - no previously-included directories found matching '.git*' 00:03:43 INFO - Installing collected packages: jsonschema, functools32 00:03:43 INFO - Running setup.py install for functools32 00:03:43 INFO - warning: no files found matching '*.txt' 00:03:43 INFO - no previously-included directories found matching 'build' 00:03:43 INFO - no previously-included directories found matching 'dist' 00:03:43 INFO - no previously-included directories found matching '.git*' 00:03:43 INFO - Successfully installed jsonschema functools32 00:03:43 INFO - Cleaning up... 00:03:44 INFO - Return code: 0 00:03:44 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 00:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:44 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0188F640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01936E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136C410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FF8520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-009', 'USERDOMAIN': 'T-W732-IX-009', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-009', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 00:03:44 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 00:03:44 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:03:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 00:03:44 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 00:03:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 00:03:44 INFO - 'COMPUTERNAME': 'T-W732-IX-009', 00:03:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 00:03:44 INFO - 'CYGWINBASE': 'C:\\cygwin', 00:03:44 INFO - 'DCLOCATION': 'SCL3', 00:03:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 00:03:44 INFO - 'FP_NO_HOST_CHECK': 'NO', 00:03:44 INFO - 'HOMEDRIVE': 'C:', 00:03:44 INFO - 'HOMEPATH': '\\Users\\cltbld', 00:03:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 00:03:44 INFO - 'KTS_VERSION': '1.19c', 00:03:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 00:03:44 INFO - 'LOGONSERVER': '\\\\T-W732-IX-009', 00:03:44 INFO - 'MONDIR': 'C:\\Monitor_config\\', 00:03:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 00:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:44 INFO - 'MOZ_NO_REMOTE': '1', 00:03:44 INFO - 'NO_EM_RESTART': '1', 00:03:44 INFO - 'NUMBER_OF_PROCESSORS': '8', 00:03:44 INFO - 'OS': 'Windows_NT', 00:03:44 INFO - 'OURDRIVE': 'C:', 00:03:44 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 00:03:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 00:03:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 00:03:44 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 00:03:44 INFO - 'PROCESSOR_LEVEL': '6', 00:03:44 INFO - 'PROCESSOR_REVISION': '1e05', 00:03:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 00:03:44 INFO - 'PROGRAMFILES': 'C:\\Program Files', 00:03:44 INFO - 'PROMPT': '$P$G', 00:03:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 00:03:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 00:03:44 INFO - 'PUBLIC': 'C:\\Users\\Public', 00:03:44 INFO - 'PWD': 'C:\\slave\\test', 00:03:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 00:03:44 INFO - 'SLAVEDIR': 'C:\\slave\\', 00:03:44 INFO - 'SYSTEMDRIVE': 'C:', 00:03:44 INFO - 'SYSTEMROOT': 'C:\\windows', 00:03:44 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:44 INFO - 'TEST1': 'testie', 00:03:44 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:44 INFO - 'USERDOMAIN': 'T-W732-IX-009', 00:03:44 INFO - 'USERNAME': 'cltbld', 00:03:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 00:03:44 INFO - 'WINDIR': 'C:\\windows', 00:03:44 INFO - 'WINDOWS_TRACING_FLAGS': '3', 00:03:44 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 00:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 00:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 00:03:44 INFO - Cleaning up... 00:03:44 INFO - Return code: 0 00:03:44 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 00:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:44 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0188F640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01936E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136C410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FF8520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-009', 'USERDOMAIN': 'T-W732-IX-009', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-009', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 00:03:44 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build 00:03:44 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:03:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 00:03:44 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 00:03:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 00:03:44 INFO - 'COMPUTERNAME': 'T-W732-IX-009', 00:03:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 00:03:44 INFO - 'CYGWINBASE': 'C:\\cygwin', 00:03:44 INFO - 'DCLOCATION': 'SCL3', 00:03:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 00:03:44 INFO - 'FP_NO_HOST_CHECK': 'NO', 00:03:44 INFO - 'HOMEDRIVE': 'C:', 00:03:44 INFO - 'HOMEPATH': '\\Users\\cltbld', 00:03:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 00:03:44 INFO - 'KTS_VERSION': '1.19c', 00:03:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 00:03:44 INFO - 'LOGONSERVER': '\\\\T-W732-IX-009', 00:03:44 INFO - 'MONDIR': 'C:\\Monitor_config\\', 00:03:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 00:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:44 INFO - 'MOZ_NO_REMOTE': '1', 00:03:44 INFO - 'NO_EM_RESTART': '1', 00:03:44 INFO - 'NUMBER_OF_PROCESSORS': '8', 00:03:44 INFO - 'OS': 'Windows_NT', 00:03:44 INFO - 'OURDRIVE': 'C:', 00:03:44 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 00:03:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 00:03:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 00:03:44 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 00:03:44 INFO - 'PROCESSOR_LEVEL': '6', 00:03:44 INFO - 'PROCESSOR_REVISION': '1e05', 00:03:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 00:03:44 INFO - 'PROGRAMFILES': 'C:\\Program Files', 00:03:44 INFO - 'PROMPT': '$P$G', 00:03:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 00:03:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 00:03:44 INFO - 'PUBLIC': 'C:\\Users\\Public', 00:03:44 INFO - 'PWD': 'C:\\slave\\test', 00:03:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 00:03:44 INFO - 'SLAVEDIR': 'C:\\slave\\', 00:03:44 INFO - 'SYSTEMDRIVE': 'C:', 00:03:44 INFO - 'SYSTEMROOT': 'C:\\windows', 00:03:44 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:44 INFO - 'TEST1': 'testie', 00:03:44 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:44 INFO - 'USERDOMAIN': 'T-W732-IX-009', 00:03:44 INFO - 'USERNAME': 'cltbld', 00:03:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 00:03:44 INFO - 'WINDIR': 'C:\\windows', 00:03:44 INFO - 'WINDOWS_TRACING_FLAGS': '3', 00:03:44 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 00:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 00:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:45 INFO - Downloading/unpacking blobuploader==1.2.4 00:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:46 INFO - Downloading blobuploader-1.2.4.tar.gz 00:03:46 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 00:03:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:46 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 00:03:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:46 INFO - Downloading docopt-0.6.1.tar.gz 00:03:46 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 00:03:47 INFO - Installing collected packages: blobuploader, requests, docopt 00:03:47 INFO - Running setup.py install for blobuploader 00:03:47 INFO - Running setup.py install for requests 00:03:48 INFO - Running setup.py install for docopt 00:03:49 INFO - Successfully installed blobuploader requests docopt 00:03:49 INFO - Cleaning up... 00:03:50 INFO - Return code: 0 00:03:50 INFO - Installing None into virtualenv C:\slave\test\build/venv 00:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:50 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 0x0188F640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01936E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136C410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FF8520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-009', 'USERDOMAIN': 'T-W732-IX-009', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-009', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 00:03:50 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 00:03:50 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 00:03:50 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 00:03:50 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 00:03:50 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 00:03:50 INFO - 'COMPUTERNAME': 'T-W732-IX-009', 00:03:50 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 00:03:50 INFO - 'CYGWINBASE': 'C:\\cygwin', 00:03:50 INFO - 'DCLOCATION': 'SCL3', 00:03:50 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 00:03:50 INFO - 'FP_NO_HOST_CHECK': 'NO', 00:03:50 INFO - 'HOMEDRIVE': 'C:', 00:03:50 INFO - 'HOMEPATH': '\\Users\\cltbld', 00:03:50 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 00:03:50 INFO - 'KTS_VERSION': '1.19c', 00:03:50 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 00:03:50 INFO - 'LOGONSERVER': '\\\\T-W732-IX-009', 00:03:50 INFO - 'MONDIR': 'C:\\Monitor_config\\', 00:03:50 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 00:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:50 INFO - 'MOZ_NO_REMOTE': '1', 00:03:50 INFO - 'NO_EM_RESTART': '1', 00:03:50 INFO - 'NUMBER_OF_PROCESSORS': '8', 00:03:50 INFO - 'OS': 'Windows_NT', 00:03:50 INFO - 'OURDRIVE': 'C:', 00:03:50 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 00:03:50 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 00:03:50 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 00:03:50 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 00:03:50 INFO - 'PROCESSOR_LEVEL': '6', 00:03:50 INFO - 'PROCESSOR_REVISION': '1e05', 00:03:50 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 00:03:50 INFO - 'PROGRAMFILES': 'C:\\Program Files', 00:03:50 INFO - 'PROMPT': '$P$G', 00:03:50 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 00:03:50 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 00:03:50 INFO - 'PUBLIC': 'C:\\Users\\Public', 00:03:50 INFO - 'PWD': 'C:\\slave\\test', 00:03:50 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 00:03:50 INFO - 'SLAVEDIR': 'C:\\slave\\', 00:03:50 INFO - 'SYSTEMDRIVE': 'C:', 00:03:50 INFO - 'SYSTEMROOT': 'C:\\windows', 00:03:50 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:50 INFO - 'TEST1': 'testie', 00:03:50 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:03:50 INFO - 'USERDOMAIN': 'T-W732-IX-009', 00:03:50 INFO - 'USERNAME': 'cltbld', 00:03:50 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 00:03:50 INFO - 'WINDIR': 'C:\\windows', 00:03:50 INFO - 'WINDOWS_TRACING_FLAGS': '3', 00:03:50 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 00:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 00:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 00:03:50 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-g7lkit-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 00:03:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 00:03:50 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-x2tn36-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 00:03:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 00:03:50 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-eogzlg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 00:03:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 00:03:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-beemkh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 00:03:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 00:03:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vwxezc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 00:03:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 00:03:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vdckkw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 00:03:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 00:03:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-_sdqu8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 00:03:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 00:03:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vow79b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 00:03:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 00:03:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-_kgvkq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 00:03:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 00:03:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vzl6qb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 00:03:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 00:03:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-jn722f-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 00:03:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 00:03:52 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vivaxa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 00:03:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 00:03:52 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bncn7f-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 00:03:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 00:03:52 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zhvog_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 00:03:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 00:03:52 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mjbreb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 00:03:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 00:03:52 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-tgrh7j-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 00:03:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 00:03:52 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9h2dxh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 00:03:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:03:52 INFO - Running setup.py install for manifestparser 00:03:53 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 00:03:53 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 00:03:53 INFO - Running setup.py install for mozcrash 00:03:54 INFO - Running setup.py install for mozdebug 00:03:54 INFO - Running setup.py install for mozdevice 00:03:54 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 00:03:54 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 00:03:54 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 00:03:54 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 00:03:55 INFO - Running setup.py install for mozfile 00:03:55 INFO - Running setup.py install for mozhttpd 00:03:55 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 00:03:55 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 00:03:56 INFO - Running setup.py install for mozinfo 00:03:56 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 00:03:56 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 00:03:56 INFO - Running setup.py install for mozInstall 00:03:56 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 00:03:56 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 00:03:56 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 00:03:56 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 00:03:56 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 00:03:56 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 00:03:56 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 00:03:56 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 00:03:56 INFO - Running setup.py install for mozleak 00:03:57 INFO - Running setup.py install for mozlog 00:03:57 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 00:03:57 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 00:03:58 INFO - Running setup.py install for moznetwork 00:03:58 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 00:03:58 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 00:03:58 INFO - Running setup.py install for mozprocess 00:03:58 INFO - Running setup.py install for mozprofile 00:03:59 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 00:03:59 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 00:03:59 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 00:03:59 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 00:03:59 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 00:03:59 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 00:03:59 INFO - Running setup.py install for mozrunner 00:03:59 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 00:03:59 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 00:04:00 INFO - Running setup.py install for mozscreenshot 00:04:00 INFO - Running setup.py install for moztest 00:04:00 INFO - Running setup.py install for mozversion 00:04:01 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 00:04:01 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 00:04:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:04:01 INFO - Cleaning up... 00:04:01 INFO - Return code: 0 00:04:01 INFO - Installing None into virtualenv C:\slave\test\build/venv 00:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:01 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 0x0188F640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01936E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136C410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FF8520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-009', 'USERDOMAIN': 'T-W732-IX-009', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-009', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 00:04:01 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 00:04:01 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 00:04:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 00:04:01 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 00:04:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 00:04:01 INFO - 'COMPUTERNAME': 'T-W732-IX-009', 00:04:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 00:04:01 INFO - 'CYGWINBASE': 'C:\\cygwin', 00:04:01 INFO - 'DCLOCATION': 'SCL3', 00:04:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 00:04:01 INFO - 'FP_NO_HOST_CHECK': 'NO', 00:04:01 INFO - 'HOMEDRIVE': 'C:', 00:04:01 INFO - 'HOMEPATH': '\\Users\\cltbld', 00:04:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 00:04:01 INFO - 'KTS_VERSION': '1.19c', 00:04:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 00:04:01 INFO - 'LOGONSERVER': '\\\\T-W732-IX-009', 00:04:01 INFO - 'MONDIR': 'C:\\Monitor_config\\', 00:04:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 00:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:01 INFO - 'MOZ_NO_REMOTE': '1', 00:04:01 INFO - 'NO_EM_RESTART': '1', 00:04:01 INFO - 'NUMBER_OF_PROCESSORS': '8', 00:04:01 INFO - 'OS': 'Windows_NT', 00:04:01 INFO - 'OURDRIVE': 'C:', 00:04:01 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 00:04:01 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 00:04:01 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 00:04:01 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 00:04:01 INFO - 'PROCESSOR_LEVEL': '6', 00:04:01 INFO - 'PROCESSOR_REVISION': '1e05', 00:04:01 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 00:04:01 INFO - 'PROGRAMFILES': 'C:\\Program Files', 00:04:01 INFO - 'PROMPT': '$P$G', 00:04:01 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 00:04:01 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 00:04:01 INFO - 'PUBLIC': 'C:\\Users\\Public', 00:04:01 INFO - 'PWD': 'C:\\slave\\test', 00:04:01 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 00:04:01 INFO - 'SLAVEDIR': 'C:\\slave\\', 00:04:01 INFO - 'SYSTEMDRIVE': 'C:', 00:04:01 INFO - 'SYSTEMROOT': 'C:\\windows', 00:04:01 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:04:01 INFO - 'TEST1': 'testie', 00:04:01 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:04:01 INFO - 'USERDOMAIN': 'T-W732-IX-009', 00:04:01 INFO - 'USERNAME': 'cltbld', 00:04:01 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 00:04:01 INFO - 'WINDIR': 'C:\\windows', 00:04:01 INFO - 'WINDOWS_TRACING_FLAGS': '3', 00:04:01 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 00:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 00:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 00:04:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-3rypax-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 00:04:01 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)) 00:04:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 00:04:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-dn8m75-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 00:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 00:04:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 00:04:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-e1sopm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 00:04:02 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)) 00:04:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 00:04:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-fac_0c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 00:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 00:04:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 00:04:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-my91qw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 00:04:02 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)) 00:04:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 00:04:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mxerpx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 00:04:02 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)) 00:04:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 00:04:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hkq0ni-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 00:04:02 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)) 00:04:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 00:04:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-duisrl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 00:04:02 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)) 00:04:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 00:04:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yr6ic1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 00:04:03 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)) 00:04:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 00:04:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pafn9d-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 00:04:03 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)) 00:04:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 00:04:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-cfbhit-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 00:04:03 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)) 00:04:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 00:04:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ygybiy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 00:04:03 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)) 00:04:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 00:04:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-z3ete7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 00:04:03 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)) 00:04:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 00:04:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-uqytec-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 00:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 00:04:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 00:04:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-exfozt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 00:04:04 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)) 00:04:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 00:04:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-s_vblu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 00:04:04 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)) 00:04:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 00:04:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-7xzgix-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 00:04:04 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)) 00:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 00:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 00:04:04 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)) 00:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 00:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 00:04:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 00:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:04:05 INFO - Downloading blessings-1.6.tar.gz 00:04:05 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 00:04:05 INFO - Installing collected packages: blessings 00:04:05 INFO - Running setup.py install for blessings 00:04:05 INFO - Successfully installed blessings 00:04:05 INFO - Cleaning up... 00:04:08 INFO - Return code: 0 00:04:08 INFO - Done creating virtualenv C:\slave\test\build/venv. 00:04:08 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 00:04:08 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 00:04:09 INFO - Reading from file tmpfile_stdout 00:04:09 INFO - Using _rmtree_windows ... 00:04:09 INFO - Using _rmtree_windows ... 00:04:09 INFO - Current package versions: 00:04:09 INFO - blessings == 1.6 00:04:09 INFO - blobuploader == 1.2.4 00:04:09 INFO - docopt == 0.6.1 00:04:09 INFO - functools32 == 3.2.3-2 00:04:09 INFO - jsonschema == 2.5.1 00:04:09 INFO - manifestparser == 1.1 00:04:09 INFO - mozInstall == 1.12 00:04:09 INFO - mozcrash == 0.17 00:04:09 INFO - mozdebug == 0.1 00:04:09 INFO - mozdevice == 0.48 00:04:09 INFO - mozfile == 1.2 00:04:09 INFO - mozhttpd == 0.7 00:04:09 INFO - mozinfo == 0.9 00:04:09 INFO - mozleak == 0.1 00:04:09 INFO - mozlog == 3.4 00:04:09 INFO - moznetwork == 0.27 00:04:09 INFO - mozprocess == 0.23 00:04:09 INFO - mozprofile == 0.28 00:04:09 INFO - mozrunner == 6.12 00:04:09 INFO - mozscreenshot == 0.1 00:04:09 INFO - mozsystemmonitor == 0.3 00:04:09 INFO - moztest == 0.7 00:04:09 INFO - mozversion == 1.4 00:04:09 INFO - psutil == 3.1.1 00:04:09 INFO - requests == 1.2.3 00:04:09 INFO - Installing None into virtualenv C:\slave\test\build/venv 00:04:09 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')]} 00:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:09 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')]} 00:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:09 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 0x0188F640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01936E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136C410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FF8520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-009', 'USERDOMAIN': 'T-W732-IX-009', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-009', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 00:04:09 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 00:04:09 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 00:04:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 00:04:09 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 00:04:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 00:04:09 INFO - 'COMPUTERNAME': 'T-W732-IX-009', 00:04:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 00:04:09 INFO - 'CYGWINBASE': 'C:\\cygwin', 00:04:09 INFO - 'DCLOCATION': 'SCL3', 00:04:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 00:04:09 INFO - 'FP_NO_HOST_CHECK': 'NO', 00:04:09 INFO - 'HOMEDRIVE': 'C:', 00:04:09 INFO - 'HOMEPATH': '\\Users\\cltbld', 00:04:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 00:04:09 INFO - 'KTS_VERSION': '1.19c', 00:04:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 00:04:09 INFO - 'LOGONSERVER': '\\\\T-W732-IX-009', 00:04:09 INFO - 'MONDIR': 'C:\\Monitor_config\\', 00:04:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 00:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:09 INFO - 'MOZ_NO_REMOTE': '1', 00:04:09 INFO - 'NO_EM_RESTART': '1', 00:04:09 INFO - 'NUMBER_OF_PROCESSORS': '8', 00:04:09 INFO - 'OS': 'Windows_NT', 00:04:09 INFO - 'OURDRIVE': 'C:', 00:04:09 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 00:04:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 00:04:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 00:04:09 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 00:04:09 INFO - 'PROCESSOR_LEVEL': '6', 00:04:09 INFO - 'PROCESSOR_REVISION': '1e05', 00:04:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 00:04:09 INFO - 'PROGRAMFILES': 'C:\\Program Files', 00:04:09 INFO - 'PROMPT': '$P$G', 00:04:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 00:04:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 00:04:09 INFO - 'PUBLIC': 'C:\\Users\\Public', 00:04:09 INFO - 'PWD': 'C:\\slave\\test', 00:04:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 00:04:09 INFO - 'SLAVEDIR': 'C:\\slave\\', 00:04:09 INFO - 'SYSTEMDRIVE': 'C:', 00:04:09 INFO - 'SYSTEMROOT': 'C:\\windows', 00:04:09 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:04:09 INFO - 'TEST1': 'testie', 00:04:09 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:04:09 INFO - 'USERDOMAIN': 'T-W732-IX-009', 00:04:09 INFO - 'USERNAME': 'cltbld', 00:04:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 00:04:09 INFO - 'WINDIR': 'C:\\windows', 00:04:09 INFO - 'WINDOWS_TRACING_FLAGS': '3', 00:04:09 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 00:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 00:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:09 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)) 00:04:09 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)) 00:04:09 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)) 00:04:09 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)) 00:04:09 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)) 00:04:09 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)) 00:04:09 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)) 00:04:09 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)) 00:04:09 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)) 00:04:09 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)) 00:04:09 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)) 00:04:09 INFO - Cleaning up... 00:04:09 INFO - Return code: 0 00:04:09 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 00:04:09 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')]} 00:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:09 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')]} 00:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:09 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 0x0188F640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01936E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136C410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FF8520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-009', 'USERDOMAIN': 'T-W732-IX-009', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-009', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 00:04: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', 'jsonschema'] in C:\slave\test\build 00:04: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 jsonschema 00:04:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 00:04:09 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 00:04:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 00:04:09 INFO - 'COMPUTERNAME': 'T-W732-IX-009', 00:04:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 00:04:09 INFO - 'CYGWINBASE': 'C:\\cygwin', 00:04:09 INFO - 'DCLOCATION': 'SCL3', 00:04:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 00:04:09 INFO - 'FP_NO_HOST_CHECK': 'NO', 00:04:09 INFO - 'HOMEDRIVE': 'C:', 00:04:09 INFO - 'HOMEPATH': '\\Users\\cltbld', 00:04:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 00:04:09 INFO - 'KTS_VERSION': '1.19c', 00:04:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 00:04:09 INFO - 'LOGONSERVER': '\\\\T-W732-IX-009', 00:04:09 INFO - 'MONDIR': 'C:\\Monitor_config\\', 00:04:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 00:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:09 INFO - 'MOZ_NO_REMOTE': '1', 00:04:09 INFO - 'NO_EM_RESTART': '1', 00:04:09 INFO - 'NUMBER_OF_PROCESSORS': '8', 00:04:09 INFO - 'OS': 'Windows_NT', 00:04:09 INFO - 'OURDRIVE': 'C:', 00:04:09 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 00:04:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 00:04:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 00:04:09 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 00:04:09 INFO - 'PROCESSOR_LEVEL': '6', 00:04:09 INFO - 'PROCESSOR_REVISION': '1e05', 00:04:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 00:04:09 INFO - 'PROGRAMFILES': 'C:\\Program Files', 00:04:09 INFO - 'PROMPT': '$P$G', 00:04:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 00:04:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 00:04:09 INFO - 'PUBLIC': 'C:\\Users\\Public', 00:04:09 INFO - 'PWD': 'C:\\slave\\test', 00:04:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 00:04:09 INFO - 'SLAVEDIR': 'C:\\slave\\', 00:04:09 INFO - 'SYSTEMDRIVE': 'C:', 00:04:09 INFO - 'SYSTEMROOT': 'C:\\windows', 00:04:09 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:04:09 INFO - 'TEST1': 'testie', 00:04:09 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:04:09 INFO - 'USERDOMAIN': 'T-W732-IX-009', 00:04:09 INFO - 'USERNAME': 'cltbld', 00:04:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 00:04:09 INFO - 'WINDIR': 'C:\\windows', 00:04:09 INFO - 'WINDOWS_TRACING_FLAGS': '3', 00:04:09 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 00:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 00:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 00:04:09 INFO - Cleaning up... 00:04:09 INFO - Return code: 0 00:04:09 INFO - Running post-action listener: _resource_record_post_action 00:04:09 INFO - Running post-action listener: _start_resource_monitoring 00:04:09 INFO - Starting resource monitoring. 00:04:09 INFO - [mozharness: 2016-09-28 07:04:09.890000Z] Finished create-virtualenv step (success) 00:04:09 INFO - [mozharness: 2016-09-28 07:04:09.890000Z] Running install step. 00:04:09 INFO - Running pre-action listener: _resource_record_pre_action 00:04:09 INFO - Running main action method: install 00:04:09 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 00:04:09 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 00:04:10 INFO - Reading from file tmpfile_stdout 00:04:10 INFO - Using _rmtree_windows ... 00:04:10 INFO - Using _rmtree_windows ... 00:04:10 INFO - Detecting whether we're running mozinstall >=1.0... 00:04:10 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 00:04:10 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 00:04:10 INFO - Reading from file tmpfile_stdout 00:04:10 INFO - Output received: 00:04:10 INFO - Usage: mozinstall-script.py [options] installer 00:04:10 INFO - Options: 00:04:10 INFO - -h, --help show this help message and exit 00:04:10 INFO - -d DEST, --destination=DEST 00:04:10 INFO - Directory to install application into. [default: 00:04:10 INFO - "C:\slave\test"] 00:04:10 INFO - --app=APP Application being installed. [default: firefox] 00:04:10 INFO - Using _rmtree_windows ... 00:04:10 INFO - Using _rmtree_windows ... 00:04:10 INFO - mkdir: C:\slave\test\build\application 00:04:10 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win32.zip', '--destination', 'C:\\slave\\test\\build\\application'] 00:04:10 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-52.0a1.en-US.win32.zip --destination C:\slave\test\build\application 00:04:12 INFO - Reading from file tmpfile_stdout 00:04:12 INFO - Output received: 00:04:12 INFO - C:\slave\test\build\application\firefox\firefox.exe 00:04:12 INFO - Using _rmtree_windows ... 00:04:12 INFO - Using _rmtree_windows ... 00:04:12 INFO - Running post-action listener: _resource_record_post_action 00:04:12 INFO - [mozharness: 2016-09-28 07:04:12.436000Z] Finished install step (success) 00:04:12 INFO - [mozharness: 2016-09-28 07:04:12.436000Z] Running run-tests step. 00:04:12 INFO - Running pre-action listener: _resource_record_pre_action 00:04:12 INFO - Running main action method: run_tests 00:04:12 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 00:04:12 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 00:04:12 INFO - Python 2.7.3 00:04:12 INFO - Return code: 0 00:04:12 INFO - grabbing minidump binary from tooltool 00:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:12 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 0x01955E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FF8520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 00:04:12 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 00:04:12 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 00:04:12 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 00:04:12 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 00:04:13 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmp9ohrqz 00:04:13 INFO - INFO - File integrity verified, renaming tmp9ohrqz to win32-minidump_stackwalk.exe 00:04:13 INFO - Return code: 0 00:04:13 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 00:04:13 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 00:04:13 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 00:04:13 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 00:04:13 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 00:04:13 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_raw.log'] in C:\slave\test\build 00:04:13 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_raw.log 00:04:13 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 00:04:13 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 00:04:13 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 00:04:13 INFO - 'COMPUTERNAME': 'T-W732-IX-009', 00:04:13 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 00:04:13 INFO - 'CYGWINBASE': 'C:\\cygwin', 00:04:13 INFO - 'DCLOCATION': 'SCL3', 00:04:13 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 00:04:13 INFO - 'FP_NO_HOST_CHECK': 'NO', 00:04:13 INFO - 'HOMEDRIVE': 'C:', 00:04:13 INFO - 'HOMEPATH': '\\Users\\cltbld', 00:04:13 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 00:04:13 INFO - 'KTS_VERSION': '1.19c', 00:04:13 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 00:04:13 INFO - 'LOGONSERVER': '\\\\T-W732-IX-009', 00:04:13 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 00:04:13 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 00:04:13 INFO - 'MONDIR': 'C:\\Monitor_config\\', 00:04:13 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 00:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:13 INFO - 'MOZ_NO_REMOTE': '1', 00:04:13 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 00:04:13 INFO - 'NO_EM_RESTART': '1', 00:04:13 INFO - 'NUMBER_OF_PROCESSORS': '8', 00:04:13 INFO - 'OS': 'Windows_NT', 00:04:13 INFO - 'OURDRIVE': 'C:', 00:04:13 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 00:04:13 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 00:04:13 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 00:04:13 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 00:04:13 INFO - 'PROCESSOR_LEVEL': '6', 00:04:13 INFO - 'PROCESSOR_REVISION': '1e05', 00:04:13 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 00:04:13 INFO - 'PROGRAMFILES': 'C:\\Program Files', 00:04:13 INFO - 'PROMPT': '$P$G', 00:04:13 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 00:04:13 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 00:04:13 INFO - 'PUBLIC': 'C:\\Users\\Public', 00:04:13 INFO - 'PWD': 'C:\\slave\\test', 00:04:13 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 00:04:13 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 00:04:13 INFO - 'SLAVEDIR': 'C:\\slave\\', 00:04:13 INFO - 'SYSTEMDRIVE': 'C:', 00:04:13 INFO - 'SYSTEMROOT': 'C:\\windows', 00:04:13 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:04:13 INFO - 'TEST1': 'testie', 00:04:13 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 00:04:13 INFO - 'USERDOMAIN': 'T-W732-IX-009', 00:04:13 INFO - 'USERNAME': 'cltbld', 00:04:13 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 00:04:13 INFO - 'WINDIR': 'C:\\windows', 00:04:13 INFO - 'WINDOWS_TRACING_FLAGS': '3', 00:04:13 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 00:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 00:04:13 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_raw.log'] with output_timeout 3600 00:04:14 INFO - mozversion application_buildid: 20160927213033 00:04:14 INFO - mozversion application_changeset: 67109e311e4c1e899eea01a5568af882ba9decc9 00:04:14 INFO - mozversion application_display_name: Nightly 00:04:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:04:14 INFO - mozversion application_name: Firefox 00:04:14 INFO - mozversion application_remotingname: firefox 00:04:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:04:14 INFO - mozversion application_vendor: Mozilla 00:04:14 INFO - mozversion application_version: 52.0a1 00:04:14 INFO - mozversion platform_buildid: 20160927213033 00:04:14 INFO - mozversion platform_changeset: 67109e311e4c1e899eea01a5568af882ba9decc9 00:04:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:04:14 INFO - mozversion platform_version: 52.0a1 00:04:14 INFO - using testdate: 1475046254 00:04:14 INFO - actual date: 1475046254 00:04:14 INFO - starting webserver on 'localhost:49893' 00:04:14 INFO - SUITE-START | Running 2 tests 00:04:14 INFO - TEST-START | dromaeo_css 00:04:14 INFO - operating with platform_type : w7_ 00:04:14 INFO - Initialising browser for dromaeo_css test... 00:04:14 INFO - TEST-INFO | started process 1116 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmphtfmd5\profile http://localhost:49893/getInfo.html) 00:04:22 INFO - PROCESS | 1116 | __metrics Screen width/height:1600/1200 00:04:22 INFO - PROCESS | 1116 | colorDepth:24 00:04:22 INFO - PROCESS | 1116 | Browser inner width/height: 1010/674 00:04:22 INFO - PROCESS | 1116 | __metrics 00:04:23 ERROR - PROCESS | 1116 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 00:04:24 INFO - TEST-INFO | 1116: exit 0 00:04:24 INFO - Browser initialized. 00:04:24 INFO - Running cycle 1/1 for dromaeo_css test... 00:04:24 INFO - TEST-INFO | started process 3804 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmphtfmd5\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:04:25 INFO - PROCESS | 3804 | [GFX1-]: Invalid size in UpdateRenderTarget Size(116,0), 0 00:04:36 INFO - PROCESS | 3804 | RSS: Main: 131809280 00:04:36 INFO - PROCESS | 3804 | 00:05:25 INFO - PROCESS | 3804 | 1475046325899 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] 00:07:33 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49893/tests/dromaeo/cssquery-ext.html) 00:07:34 INFO - PROCESS | 3804 | RSS: Main: 111173632 00:07:34 INFO - PROCESS | 3804 | 00:10:36 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-ext.html (next: http://localhost:49893/tests/dromaeo/cssquery-jquery.html) 00:10:37 INFO - PROCESS | 3804 | RSS: Main: 82903040 00:10:37 INFO - PROCESS | 3804 | 00:13:38 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49893/tests/dromaeo/cssquery-mootools.html) 00:13:39 INFO - PROCESS | 3804 | RSS: Main: 74764288 00:13:39 INFO - PROCESS | 3804 | 00:16:41 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49893/tests/dromaeo/cssquery-prototype.html) 00:16:41 INFO - PROCESS | 3804 | RSS: Main: 75112448 00:16:41 INFO - PROCESS | 3804 | 00:19:44 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49893/tests/dromaeo/cssquery-yui.html) 00:19:44 INFO - PROCESS | 3804 | RSS: Main: 74219520 00:19:44 INFO - PROCESS | 3804 | 00:22:47 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-yui.html (next: http://localhost:49893/tests/dromaeo/cssquery-dojo.html) 00:22:47 INFO - PROCESS | 3804 | RSS: Main: 61206528 00:22:47 INFO - PROCESS | 3804 | 00:22:47 INFO - PROCESS | 3804 | __start_tp_report 00:22:47 INFO - PROCESS | 3804 | _x_x_mozilla_page_load 00:22:47 INFO - PROCESS | 3804 | _x_x_mozilla_page_load_details 00:22:47 INFO - PROCESS | 3804 | |i|pagename|runs| 00:22:47 INFO - PROCESS | 3804 | |0;dojo.html;2843.8151520151196;2890.5664150377443;2914.1548950804267;2917.606123173371;2922.240217543438;5068.49315068493;5102.234664800277;5106.2851200831865;5211.114110601197;5211.114110601197;5071.1886098224295;5084.3136176616235;5145.845624631258;5163.535281824635;5193.402758682752;4304.74171549708;4498.775061246941;4527.932081018779;4596.6092882104895;4598.310253461991;107.00208814698584;4182.121754431573;4487.596116349528;4489.1695036418205;4489.2817149256125;4313;4397.340398940152;4414;4455.509893911667;4462.419885414892;4356.89107772305;4469.284914413711;4491.865244042651;4495.64034877209;4500.144972455256;4363.170997510463;4380.649548036149;4434.49003364614;4463.062756821071;4471.642268618502;4981.750912454363;5020.4226513951;5027.572656324217;5041.59667226621;5058.924116138261;5317.308749862532;5327.174287985368;5328.20076988451;5335.1997200419855;5335.759890804923;5318.547923426513;5349.197620356938;5382.1119515280325;5385.084535628953;5393.514583687448;4954.554090131869;4956.950430495721;4995.450500444948;4999.675021123615;5001.324821149171;5306.867328316823;5449.863753406196;5471.671699698031;5512.310961129899;5520.006398848246;5188.92216616751;5197.142471492237;5250.7637156328055;5257.421683614799;5266.131088370376;5069.5944324454695;5238.842834714888;5354.196870469383;5388.407275199725;5410.621256512085;5241.161414173714;5258.579313654975;5359.276497672764;5361.946380536223;5380.596455265871;5170.560502357342;5235.869103272373;5310.097283461821;5339.199120132012;5347.850212204317;3541.1678255609913;3576.7317451191266;3585.6235095315137;3587.7847329160336;3592.6227746086806;3154.3375891062674;3192.3136525647096;3248.4964830451318;3263.0863358259726;3271.6237632672546;5060.898782024339;5145.871353216199;5197.792088316501;5303.496167864047;5319.707416092152;5334.226537152092;5349.545288650508;5389.865253368619;5524.033294173503;5546.084895992197;5111.744412779421;5191.714455704972;5195.818146364859;5203.037438073969;5251.2123181523075;4360.869173924787;4458.175237580993;4551.544845515422;4562.68061235717;4570.748608826547;5550.417206193291;5751.424857514216;5760;5799.8550036249435;5862.912056319158;5348.625596208383;5394.703291319015;5459.50864422188;5511.559075273888;5540.972295138498;5650.26546548946;5677.432256774289;5687.260656114679;5737.483626473638;5872.265966754156;5163.225516172604;5308.495692909168;5318.654287471302;5323.547498462674;5361.892762144657;5423.566114710892;5467.644603100785;5563.054280772198;5566.638168519034;5576.247206627054;5245.921311180259;5281.867953301198;5378.811741589026;5396.487333703292;5398.46015398457;5181.715005674724;5193.480651934928;5222.764975576032;5287.286216360896;5369.3556773187465;5151.613628977767;5255.211718242294;5262.342207224097;5277.736113194402;5282.022825777243;5231.738413079407;5289.894202116013;5366.785328586813;5385.192221166856;5409.350877894678;5131.076406246912;5154.922676159786;5206.375234971828;5230.7384630769075;5331.493508116722 00:22:47 INFO - PROCESS | 3804 | |1;ext.html;527.6622961304763;543.8885028569143;572.9915348985786;576.6050255574931;587.7296443635927;29176;31082.378352432966;40036.59963400365;40449.59550404491;41233;41154.38268425976;41336.58663413365;41461.17077658445;41502;41553.58446415535;8405.108850508632;8543.102974187714;8544.23101920827;8568.742937711848;8570.285942811463;8365.12166222547;8386.916130838705;8395.118512556186;8484.066752657234;8509.361797865155;8351.039630442516;8480.321574274043;8541.615627296755;8545.786355341135;8549.358798090137;8455.069942306342;8459.196376344269;8461.365397595206;8507.744767657012;8511.702090426805;8344.165583441669;8367;8418.410711250215;8427.662893484254;8467.618957146882;38209.23581528381;38854.02864928371;38952.80523597392;39124.41313380301;39238;2915.7958942874006;2928.8389138597367;2945.7496112830436;3222.6455089940087;3485.233248685285;30474.238144046354;30667.386652267054;30945.690543094504;31276.687233127606;31483.685163148304;3482.373172828915;3536.8054756988354;3561.465780132975;3567.661072198163;3594.946075808865;264049;312149;314706;317184.41407793044;317648;50798.968041277934;51103.744481277354;51481.48518514842;51493;51514.74242628763;28633.427331453255;29055;29209.85395073011;52976.20535691968;53222.73388633032;12866.871331286755;12989.28558929249;13053;13080.738385232242;13097.476100956046;10339.63811266602;10394.740131496621;10521.105706015074;10535.104516116216;10543.472826358651;16997.660046799243;17186.22661980214;17261.309547618206;17277.049762262945;17335.21991510385;6686.83282917931;6690.230623478362;6742.325767423316;6799.4900382471515;6813.829654258683;762.3443838299058;789.4947233770391;899.7525680437932;933.6452148183647;994.5425104451889;28245.293867653472;28761.71238287632;28927.85536072306;29221.561676574867;29272.85363573211;869.0310304011109;895.8712022851124;899.0784445942961;900.3832374823136;930.8650245714333;14558.927205363905;14718.926405367905;14770.335334909954;14867;14921.552353429415;492681;493164;497453;498571;504267;48133.5186648129;48224;48245.27632085521;48324.758376207894;48387.5161248383;1077.5528155815248;1089.9400532970762;1090.5692251560747;1095.479647167605;1138.3113216504062;26620.866895665396;27458.588121178596;27546;27931.720682793726;27957.860210698815;43259.918502037704;43853.12293754043;44044;44084.33873491964;44291.55708443003;452796;454331;455509;457563;457844.48021756957;23040;23170;23197.768022320237;23325.41686457852;23344.53310933806;42750.144997100506;43123.784381077894;43313.783431082644;43792.343114852665;43849;35639.28721425609;36954.26091478209;37118.44322335221;37498.43752343662;37968.43047354347;37032.25935481329;37117.81441092777;37172.81413593023;37574;37670.86987390383;29187.270318242216;31796.6820331803;34757.826210869796;35187.296254075285;35290.647093528736;31893;32515.837420812746;32593;33275.33449331048;33307.16732081717;25138.748612513642;25355.492890142465;25864;26044.73955260423;26201.21396358036 00:22:47 INFO - PROCESS | 3804 | |2;jquery.html;307.3453543951383;307.84146164725166;310.51869602116716;314.6255955413058;325.22758448684374;17235.48293551194;17398.91300543497;17485.56286092847;17865.374711885088;17986.550336241602;15326.846731532682;15958.28187731552;16178;16292.83707162931;16437.42469013585;4781.16329642312;4881;4908.533689299528;4912.042151780404;4912.091263116317;4749.240121580548;4866.586340161073;4900.877478063041;4902.534259245366;4915.950840491585;4606.60843828275;4830.492798256185;4880.170371036915;4889.119958407486;4895.55939965403;4846.297286893398;4875.804967801284;4880.536349046835;4880.951190488086;4920.655554111214;4632.837850675211;4692.671512994092;4699.530046995307;4708.646851486153;4715.834945776881;20675.5864882703;21416.357509274745;21534.353969380943;21645.67531487029;21703;1653.7602047703015;1723.9396621118326;1747.571844898008;1906.0565020314893;1907.275235410535;9102.271818254523;9146.314026448043;10856.945715271373;13611.52359667407;14269.571912842632;1748.9212985415559;1798.2447372103748;1825.0327326516835;1833.4774589242002;1834.2754611928347;78146;82402.17597824005;83344;86511.70232446518;87189.56405217997;8983.730488085237;9061.59222834974;9252.90747092534;9306.2089722373;9390.62437502506;12075.51697932073;12117.878821211674;12126.514939402501;12148.331841748612;12163.148579599343;7033.120859892513;7193.280671932765;7222.602756848424;7238.0952380952385;7277.7452789153185;7193.568385896863;7201.495895287384;7213.026241457336;7294.3799777018485;7308.488405811649;3786.1670432504807;3810.3903375459795;3823.5985221551337;3831.3103641344824;3867.1298957734284;1584.5880071181346;1588.110658031506;1594.4977332140338;1602.9198540073182;1611.484325016007;770.022071968608;782.3701919954491;785.9056913170456;786.1666633368533;806.1776987472745;17877;17904;18314.26742930268;18356.724649130272;18792.71810922837;830.5639539241946;859.6733241368365;861.9698310559226;866.6533386645392;930.7300882743929;9701.90298097024;10310.43292618913;10313.948430257951;10318;10404.895951040544;369502;376155;376796;383484;387786;91934;93555;94726;95445.52277238708;96470.03529964751;813.938954578409;829.7510746776064;829.9626516806758;830.7964548685611;834.2991886815105;16178.315300232296;16282.67434651324;16505.092219927537;16642.833571664127;16670.16649167561;32596.674033259365;40133.59866401416;42673.35989960091;43249;44243;56995.71502142463;59821.40178598158;60824.39175608187;61746;62589.68705156445;6893.551919125241;7235.384992275715;7267.200607933018;7355.117385913724;7419.666115024729;12026.699332516757;12349.32078735678;12604;12842.550510732453;13102.868971310165;9531.523423828643;10688.679339619825;10709.036186743231;10717.35695858251;10894;10183.18534517222;10486.52810623539;10593.629222977159;10633.468326583485;10911;10854.403007834644;10854.457277135954;10947.890521094687;11035.944820275847;11246.212765106691;5933.199018132497;6256.937430625636;6394.296627370893;6533.67331633426;6560.868782624416;7115.857682846417;8315.750527484186;10502.527386267484;10582.365058096539;10673.679789606324 00:22:47 INFO - PROCESS | 3804 | |3;mootools.html;1139.9056905370844;1142.8114361130413;1248.7939489984153;1491.3587157522268;1513.9545813625596;6772.864542709149;6816.931830681691;6835.624040677761;7252.3110304521115;7269.563826170427;7172.533785303952;7279.19928807832;7291.343779059884;7292.234315396887;7317.414606831454;1941.4272789527124;1942.786293507713;1972.901354932255;1975.140813746025;1976.0811222781404;1937.9224831006813;1941.0585865855048;1948.434953863385;1957.2562426277993;1959.7158412030246;1951.9684175896477;1966.7934866838991;1968.2323893681476;1970.5467742419253;1970.9113089910916;1855.7030875059993;1869.5513076861591;1872.6441976024648;1878.8966606836618;1881.1910878322317;1865.9160337784833;1870.1958157992058;1882.962340753191;1886.4623582278984;1888.4051523769967;7024.824379390505;7096.183938847047;7113.893291600579;7120.928790712079;7124.5725256484775;4143.440635514197;4266.338717498793;4357;4361.345798130305;4373.715708478971;2622.3837398211595;2676.8795404206858;2695.986520067387;2711.6068170115223;2711.7288271172924;787.5786454246951;809.5830647216688;815.0545367373877;815.388458656008;822.3462347433805;8884.022757496605;8965.162141760924;8966.910330896739;9001.819963600692;9043.457392556402;3527.1358517162944;3568.57177138745;3606.0804494853646;3621.6016238213774;3639.6178401267484;7186.389156921616;7279.12650481935;7291.125064992235;7300.744473943387;7301.561906285639;4156.355764856452;4229.175310814362;4257.084726783694;4260.169266992969;4265.402843601898;3424.2466657335344;3444.689977902001;3917.8236979335998;3975.6421922027157;4045.959540404558;2946.720061594145;3013.2768135647725;3033.5904652872023;3041.2548925512947;3042.34589563245;903.6837107012493;916.0335845682869;917.9724608261763;919.0992827029415;919.4850883505259;682.3585829320522;682.8292926768308;736.3814395907357;806.435495153395;813.8494378539989;4790.089882922233;4806.711597304173;4836.806527738921;4843.951560484421;4948.307236986825;765.739648519495;770.218228498075;787.7715462515806;798.7938213297846;802.2699343597299;3372.0895358253624;3401.846916888746;3411.846466908995;3438.1404648837793;3492.284081763283;8257.710980115788;8464.15358464161;8610.569471526398;8628.956855215683;8682.43564168327;8495.447795893248;8659.783505412415;8663.696770612998;8668.393212475192;8670.436421632574;6648.301928297556;6729.629870357079;6761.966190169018;6780.220274668378;6800.557963732342;4848.878778030577;4883.804647814048;4912.557869791736;4999.77501012448;5027.824026159067;8035.55804430762;8043.959780201061;8183;8191.672333106847;8235.711750088718;7968.561729104955;8255.25702686761;8291.875621865556;8306.377021723274;8365.330773538224;5860.267466566679;5883.705814709333;5883.794067207798;5885.028970219866;5915;6246;6465.1595292611655;6745.696443660146;6940.548864323803;6975.093237879043;6222.191115155182;6283.120363149254;6285.654289014148;6301.306856245717;6334.3665633436285;5948.37542058095;6081.331053584191;6082.209312789486;6149.754009839557;6173.876522469435;5841.211436456024;5841.452015216056;5894.20428242199;5898.764049438146;5899.410058994066;4151.522574903925;4166.895827604334;4216.409702641694;4220.535741068541;4283.507396649301;4175.290200665833;4218.8523401680795;4224.640905523065;4230.640395566288;4302.376155457378 00:22:47 INFO - PROCESS | 3804 | |4;prototype.html;244.5939740031548;246.18758098275686;246.2489407307711;255.7698071735438;256.3578236517523;5287.339082614673;5383.542398896094;5463.3717122530925;5482.780688772449;5511.669299842008;5240.947590524103;5365.436629153941;5365.651232669884;5369.382521010085;5401.540869026137;3780.3006443807844;3934.1738234970617;3934.95723633236;3936.4488971544006;3937.488126543545;3916.647501724844;3933.744306620075;3934.350832112698;3935.822887970048;3937.1338305572726;3782.3948168293077;3790.9810450947707;3862.439946207798;3891.474650922132;3899.512560929884;3817.3319669057805;3858.4791053207878;3863.2273545290914;3868.3617203161443;3870.845166193349;3200.9116900253794;3308.4541050726602;3318.634950155481;3325.0523600773663;3325.3681800457834;5239;5266.947330526684;5267.5769146192415;5270.209468579706;5275.182346736262;4543.568361005699;4544.590986811169;4545.613622842063;4550.5427069382495;4559.817607295704;5396.406395296514;5565.276514053187;5579.888402231933;5601.467860553282;5613.410591887875;3640.908977275563;3695.2078242052585;3714.517112775349;3718.5537735471917;3729.291434627412;5883.588148829584;5890;5896.911546326808;5913.349531551526;5922.763089476459;3803.54357477099;3806.1920587721165;3816.866409675648;3819.579846216914;3827.827747751358;3528.2061536154674;3704.129529560551;3722.10669439338;3723.739338246297;3725.0873535983856;4425.955740442619;4443.888902777457;4445.777711114431;4452.220861349251;4454.153710794939;5639.407862174413;5678.346990096192;5678.375378708339;5687.232223649754;5696.572757043238;1268.1566758105942;1275.2922128218927;1281.0520215040804;1281.7820970435048;1282.9294388808705;766.2605585609913;780.7696729464822;783.764870538836;809.7651681012441;819.9221073997961;5509.228707980886;5544.91682624761;5545.168224766237;5555.777768889199;5563.805266815642;5774.480296773227;5819.388964158702;5824.242848429677;5831.504322132581;5851.220670181629;5543.750531226105;5559.277293951841;5577.330720313588;5579.38626751057;5590.440955904377;2990.8355040472547;3135.65166978197;3157.684231576824;3161.2413020874824;3163.6994485523837;6275.309715931244;6326.810195694136;6347.079673447417;6356.77751278703;6359.554831161774;5847.532197424281;5986.2217911671205;6029.508016527715;6032.366601506867;6053.122297266959;6282.340354262828;6299.299189218886;6316.8420789479715;6317.557770956081;6344.651044192614;5812.883742325045;5931.555133365101;5940.554458415722;5946.494547963299;5949.583529152917;5803.506701930383;5820.388859169896;5842.211301474246;5858;5866.208061911758;6087.57386982907;6246.312905580292;6322.36776322364;6334.864242199956;6361.395667411589;3629.3830048891223;3657.4879516867127;3661.2494438640547;3672.981635091807;3673.669369756628;5900.144479050599;5925.970370148294;5931.940680593311;5933.736444955343;5945.91081133792;5486.533644640251;5693.971530142323;5710.828675139753;5712.542996560348;5730.255066841284;5676.438979280731;5685.204071430086;5698.686572238566;5703.429657034263;5736.282964629421;5531.3362396512675;5585.860353491195;5588.3573389060775;5588.580856435865;5594.356648985256;5444.673319600678;5554.222408862682;5670.8015219467125;5725.370209277059;5730.484256416776;5582.497575218087;5646.7458964347525;5660.207570940154;5676.659400435822;5683.346415162144 00:22:47 INFO - PROCESS | 3804 | |5;yui.html;626.0796628955437;669.374135183603;690.2993461636438;695.1137299942573;709.1383968478298;14896.702065958674;15735.449259275927;15737.606559835995;15795.131267780267;16083.517494475154;15038.774418383733;15651.92174039131;15664.451744188955;15732;15784.763228551581;609.7926704920326;628.6448156791421;635.6027482823235;640.2413140428583;642.5437939063271;510.95656869166163;524.8425472358297;619.9845003874894;629.380060640269;631.8041407163771;648.6983552648018;652.562782935432;664.8803215421223;665.6072916978982;665.6704931059132;655.7278729327323;656.0749343425771;656.3338211715113;658.3811217455624;659.3933581105395;477.9283107533863;478.7869398117839;480.3227449296475;481.383828699262;481.82172596139304;14586.197759123244;14721.631959200999;14772.926135369362;14788.260586970717;14855.554333370017;13033.54382596614;13127.146735462164;13251.933740331237;13331.146432867154;13388.129771564914;11994.22037567564;12112.697182570419;12159.088068394818;12237.694057648541;12269.57056503018;3583.068402215443;3583.4445660922597;3588.4976103345552;3621.384364657988;3673.5040769496045;80507.5974620129;81091.51267898612;81605;82298;82867.58566207191;10391.792164156675;10421.478926053818;10453.84319235212;10485.05634492884;10759.139268858473;18628.068596570116;18696.719549206773;18727;18728.15723292455;18747.25010999572;7392.075990501187;7393.186749457555;7396.815079622945;7481.438892083115;7497.400207983348;4014.277430062617;4019.196160767858;4117.238310912491;4183.330667093251;4321.092570560218;2864;3043.3000409905844;3069.493533566981;3080;3084.491058975289;537.1378936806448;540.0549039181433;540.6215649045683;541.4504278157673;543.6982474726485;588.5232961301359;669.7138314785412;680.0852852912824;684.8664510420421;687.9753442362141;9831;10015.399076055315;10110.595576177018;10249.282550221413;10377.533011014371;627.7915013598895;652.4780175859294;674.1741366825697;707.3775077931388;715.4669771020519;4588.770561471913;4874.951250487521;5001.969868492597;5111.795528178905;5317.388500322435;106751;117942;118052.24346956631;119858;122686;74742;95771.52114239385;96726.51636741772;97530;101090;83848.58075709705;85440.14559854323;86168.56915715382;86234;88285.99999999872;9553.665621703207;9811.116999470081;9898.802023959624;9972.551235194578;10009.299349045497;51032.48967510426;51382.48617513777;51442;51933.22100168576;52054.73972630112;59733.701331494805;61344;62750;68467.65766171138;68648;13463.865361346261;13603;13627;13672.65818354549;13869.583912482642;14724.77912831287;15129.621759456102;15207.391704332145;15472.690546188787;15907.681846363239;13136;13185.142965707199;13226.762281815769;13238.602841914759;13838.37727302294;14214.715705686036;14220.431182752574;14351;14533.781993269899;14856.108633482027;13405.128666637027;13520;13970.301484925916;13977.510787122403;14232.015812244896;11409.657710268706;11646.592369267035;11719.238249513754;11980.940095299467;12111.939440302742;11701.648950531498;11756.82364764512;11805.173637845268;11863;11909.166358355178 00:22:47 INFO - PROCESS | 3804 | __end_tp_report 00:22:47 INFO - PROCESS | 3804 | __start_cc_report 00:22:47 INFO - PROCESS | 3804 | _x_x_mozilla_cycle_collect,263 00:22:47 INFO - PROCESS | 3804 | __end_cc_report 00:22:47 INFO - PROCESS | 3804 | __startTimestamp1475047367381__endTimestamp 00:22:47 INFO - PROCESS | 3804 | 00:22:47 INFO - PROCESS | 3804 | ------- Summary: start ------- 00:22:47 INFO - PROCESS | 3804 | Number of tests: 6 00:22:47 INFO - PROCESS | 3804 | 00:22:47 INFO - PROCESS | 3804 | [#0] dojo.html Cycles:165 Average:4940.84 Median:5211.11 stddev:766.39 (14.7%) stddev-sans-first:750.87 00:22:47 INFO - PROCESS | 3804 | Values: 2843.8 2890.6 2914.2 2917.6 2922.2 5068.5 5102.2 5106.3 5211.1 5211.1 5071.2 5084.3 5145.8 5163.5 5193.4 4304.7 4498.8 4527.9 4596.6 4598.3 107.0 4182.1 4487.6 4489.2 4489.3 4313.0 4397.3 4414.0 4455.5 4462.4 4356.9 4469.3 4491.9 4495.6 4500.1 4363.2 4380.6 4434.5 4463.1 4471.6 4981.8 5020.4 5027.6 5041.6 5058.9 5317.3 5327.2 5328.2 5335.2 5335.8 5318.5 5349.2 5382.1 5385.1 5393.5 4954.6 4957.0 4995.5 4999.7 5001.3 5306.9 5449.9 5471.7 5512.3 5520.0 5188.9 5197.1 5250.8 5257.4 5266.1 5069.6 5238.8 5354.2 5388.4 5410.6 5241.2 5258.6 5359.3 5361.9 5380.6 5170.6 5235.9 5310.1 5339.2 5347.9 3541.2 3576.7 3585.6 3587.8 3592.6 3154.3 3192.3 3248.5 3263.1 3271.6 5060.9 5145.9 5197.8 5303.5 5319.7 5334.2 5349.5 5389.9 5524.0 5546.1 5111.7 5191.7 5195.8 5203.0 5251.2 4360.9 4458.2 4551.5 4562.7 4570.7 5550.4 5751.4 5760.0 5799.9 5862.9 5348.6 5394.7 5459.5 5511.6 5541.0 5650.3 5677.4 5687.3 5737.5 5872.3 5163.2 5308.5 5318.7 5323.5 5361.9 5423.6 5467.6 5563.1 5566.6 5576.2 5245.9 5281.9 5378.8 5396.5 5398.5 5181.7 5193.5 5222.8 5287.3 5369.4 5151.6 5255.2 5262.3 5277.7 5282.0 5231.7 5289.9 5366.8 5385.2 5409.4 5131.1 5154.9 5206.4 5230.7 5331.5 00:22:47 INFO - PROCESS | 3804 | 00:22:47 INFO - PROCESS | 3804 | [#1] ext.html Cycles:180 Average:55314.42 Median:38531.63 stddev:113738.36 (295.2%) stddev-sans-first:113983.04 00:22:47 INFO - PROCESS | 3804 | Values: 527.7 543.9 573.0 576.6 587.7 29176.0 31082.4 40036.6 40449.6 41233.0 41154.4 41336.6 41461.2 41502.0 41553.6 8405.1 8543.1 8544.2 8568.7 8570.3 8365.1 8386.9 8395.1 8484.1 8509.4 8351.0 8480.3 8541.6 8545.8 8549.4 8455.1 8459.2 8461.4 8507.7 8511.7 8344.2 8367.0 8418.4 8427.7 8467.6 38209.2 38854.0 38952.8 39124.4 39238.0 2915.8 2928.8 2945.7 3222.6 3485.2 30474.2 30667.4 30945.7 31276.7 31483.7 3482.4 3536.8 3561.5 3567.7 3594.9 264049.0 312149.0 314706.0 317184.4 317648.0 50799.0 51103.7 51481.5 51493.0 51514.7 28633.4 29055.0 29209.9 52976.2 53222.7 12866.9 12989.3 13053.0 13080.7 13097.5 10339.6 10394.7 10521.1 10535.1 10543.5 16997.7 17186.2 17261.3 17277.0 17335.2 6686.8 6690.2 6742.3 6799.5 6813.8 762.3 789.5 899.8 933.6 994.5 28245.3 28761.7 28927.9 29221.6 29272.9 869.0 895.9 899.1 900.4 930.9 14558.9 14718.9 14770.3 14867.0 14921.6 492681.0 493164.0 497453.0 498571.0 504267.0 48133.5 48224.0 48245.3 48324.8 48387.5 1077.6 1089.9 1090.6 1095.5 1138.3 26620.9 27458.6 27546.0 27931.7 27957.9 43259.9 43853.1 44044.0 44084.3 44291.6 452796.0 454331.0 455509.0 457563.0 457844.5 23040.0 23170.0 23197.8 23325.4 23344.5 42750.1 43123.8 43313.8 43792.3 43849.0 35639.3 36954.3 37118.4 37498.4 37968.4 37032.3 37117.8 37172.8 37574.0 37670.9 29187.3 31796.7 34757.8 35187.3 35290.6 31893.0 32515.8 32593.0 33275.3 33307.2 25138.7 25355.5 25864.0 26044.7 26201.2 00:22:47 INFO - PROCESS | 3804 | 00:22:47 INFO - PROCESS | 3804 | [#2] jquery.html Cycles:180 Average:25232.35 Median:41403.48 stddev:63602.11 (153.6%) stddev-sans-first:63752.99 00:22:47 INFO - PROCESS | 3804 | Values: 307.3 307.8 310.5 314.6 325.2 17235.5 17398.9 17485.6 17865.4 17986.6 15326.8 15958.3 16178.0 16292.8 16437.4 4781.2 4881.0 4908.5 4912.0 4912.1 4749.2 4866.6 4900.9 4902.5 4916.0 4606.6 4830.5 4880.2 4889.1 4895.6 4846.3 4875.8 4880.5 4881.0 4920.7 4632.8 4692.7 4699.5 4708.6 4715.8 20675.6 21416.4 21534.4 21645.7 21703.0 1653.8 1723.9 1747.6 1906.1 1907.3 9102.3 9146.3 10856.9 13611.5 14269.6 1748.9 1798.2 1825.0 1833.5 1834.3 78146.0 82402.2 83344.0 86511.7 87189.6 8983.7 9061.6 9252.9 9306.2 9390.6 12075.5 12117.9 12126.5 12148.3 12163.1 7033.1 7193.3 7222.6 7238.1 7277.7 7193.6 7201.5 7213.0 7294.4 7308.5 3786.2 3810.4 3823.6 3831.3 3867.1 1584.6 1588.1 1594.5 1602.9 1611.5 770.0 782.4 785.9 786.2 806.2 17877.0 17904.0 18314.3 18356.7 18792.7 830.6 859.7 862.0 866.7 930.7 9701.9 10310.4 10313.9 10318.0 10404.9 369502.0 376155.0 376796.0 383484.0 387786.0 91934.0 93555.0 94726.0 95445.5 96470.0 813.9 829.8 830.0 830.8 834.3 16178.3 16282.7 16505.1 16642.8 16670.2 32596.7 40133.6 42673.4 43249.0 44243.0 56995.7 59821.4 60824.4 61746.0 62589.7 6893.6 7235.4 7267.2 7355.1 7419.7 12026.7 12349.3 12604.0 12842.6 13102.9 9531.5 10688.7 10709.0 10717.4 10894.0 10183.2 10486.5 10593.6 10633.5 10911.0 10854.4 10854.5 10947.9 11035.9 11246.2 5933.2 6256.9 6394.3 6533.7 6560.9 7115.9 8315.8 10502.5 10582.4 10673.7 00:22:47 INFO - PROCESS | 3804 | 00:22:47 INFO - PROCESS | 3804 | [#3] mootools.html Cycles:180 Average:4614.02 Median:5889.62 stddev:2558.12 (43.4%) stddev-sans-first:2551.97 00:22:47 INFO - PROCESS | 3804 | Values: 1139.9 1142.8 1248.8 1491.4 1514.0 6772.9 6816.9 6835.6 7252.3 7269.6 7172.5 7279.2 7291.3 7292.2 7317.4 1941.4 1942.8 1972.9 1975.1 1976.1 1937.9 1941.1 1948.4 1957.3 1959.7 1952.0 1966.8 1968.2 1970.5 1970.9 1855.7 1869.6 1872.6 1878.9 1881.2 1865.9 1870.2 1883.0 1886.5 1888.4 7024.8 7096.2 7113.9 7120.9 7124.6 4143.4 4266.3 4357.0 4361.3 4373.7 2622.4 2676.9 2696.0 2711.6 2711.7 787.6 809.6 815.1 815.4 822.3 8884.0 8965.2 8966.9 9001.8 9043.5 3527.1 3568.6 3606.1 3621.6 3639.6 7186.4 7279.1 7291.1 7300.7 7301.6 4156.4 4229.2 4257.1 4260.2 4265.4 3424.2 3444.7 3917.8 3975.6 4046.0 2946.7 3013.3 3033.6 3041.3 3042.3 903.7 916.0 918.0 919.1 919.5 682.4 682.8 736.4 806.4 813.8 4790.1 4806.7 4836.8 4844.0 4948.3 765.7 770.2 787.8 798.8 802.3 3372.1 3401.8 3411.8 3438.1 3492.3 8257.7 8464.2 8610.6 8629.0 8682.4 8495.4 8659.8 8663.7 8668.4 8670.4 6648.3 6729.6 6762.0 6780.2 6800.6 4848.9 4883.8 4912.6 4999.8 5027.8 8035.6 8044.0 8183.0 8191.7 8235.7 7968.6 8255.3 8291.9 8306.4 8365.3 5860.3 5883.7 5883.8 5885.0 5915.0 6246.0 6465.2 6745.7 6940.5 6975.1 6222.2 6283.1 6285.7 6301.3 6334.4 5948.4 6081.3 6082.2 6149.8 6173.9 5841.2 5841.5 5894.2 5898.8 5899.4 4151.5 4166.9 4216.4 4220.5 4283.5 4175.3 4218.9 4224.6 4230.6 4302.4 00:22:47 INFO - PROCESS | 3804 | 00:22:47 INFO - PROCESS | 3804 | [#4] prototype.html Cycles:180 Average:4695.26 Median:5544.33 stddev:1524.86 (27.5%) stddev-sans-first:1492.10 00:22:47 INFO - PROCESS | 3804 | Values: 244.6 246.2 246.2 255.8 256.4 5287.3 5383.5 5463.4 5482.8 5511.7 5240.9 5365.4 5365.7 5369.4 5401.5 3780.3 3934.2 3935.0 3936.4 3937.5 3916.6 3933.7 3934.4 3935.8 3937.1 3782.4 3791.0 3862.4 3891.5 3899.5 3817.3 3858.5 3863.2 3868.4 3870.8 3200.9 3308.5 3318.6 3325.1 3325.4 5239.0 5266.9 5267.6 5270.2 5275.2 4543.6 4544.6 4545.6 4550.5 4559.8 5396.4 5565.3 5579.9 5601.5 5613.4 3640.9 3695.2 3714.5 3718.6 3729.3 5883.6 5890.0 5896.9 5913.3 5922.8 3803.5 3806.2 3816.9 3819.6 3827.8 3528.2 3704.1 3722.1 3723.7 3725.1 4426.0 4443.9 4445.8 4452.2 4454.2 5639.4 5678.3 5678.4 5687.2 5696.6 1268.2 1275.3 1281.1 1281.8 1282.9 766.3 780.8 783.8 809.8 819.9 5509.2 5544.9 5545.2 5555.8 5563.8 5774.5 5819.4 5824.2 5831.5 5851.2 5543.8 5559.3 5577.3 5579.4 5590.4 2990.8 3135.7 3157.7 3161.2 3163.7 6275.3 6326.8 6347.1 6356.8 6359.6 5847.5 5986.2 6029.5 6032.4 6053.1 6282.3 6299.3 6316.8 6317.6 6344.7 5812.9 5931.6 5940.6 5946.5 5949.6 5803.5 5820.4 5842.2 5858.0 5866.2 6087.6 6246.3 6322.4 6334.9 6361.4 3629.4 3657.5 3661.2 3673.0 3673.7 5900.1 5926.0 5931.9 5933.7 5945.9 5486.5 5694.0 5710.8 5712.5 5730.3 5676.4 5685.2 5698.7 5703.4 5736.3 5531.3 5585.9 5588.4 5588.6 5594.4 5444.7 5554.2 5670.8 5725.4 5730.5 5582.5 5646.7 5660.2 5676.7 5683.3 00:22:47 INFO - PROCESS | 3804 | 00:22:47 INFO - PROCESS | 3804 | [#5] yui.html Cycles:180 Average:20472.95 Median:3843.89 stddev:29596.82 (770.0%) stddev-sans-first:29642.33 00:22:47 INFO - PROCESS | 3804 | Values: 626.1 669.4 690.3 695.1 709.1 14896.7 15735.4 15737.6 15795.1 16083.5 15038.8 15651.9 15664.5 15732.0 15784.8 609.8 628.6 635.6 640.2 642.5 511.0 524.8 620.0 629.4 631.8 648.7 652.6 664.9 665.6 665.7 655.7 656.1 656.3 658.4 659.4 477.9 478.8 480.3 481.4 481.8 14586.2 14721.6 14772.9 14788.3 14855.6 13033.5 13127.1 13251.9 13331.1 13388.1 11994.2 12112.7 12159.1 12237.7 12269.6 3583.1 3583.4 3588.5 3621.4 3673.5 80507.6 81091.5 81605.0 82298.0 82867.6 10391.8 10421.5 10453.8 10485.1 10759.1 18628.1 18696.7 18727.0 18728.2 18747.3 7392.1 7393.2 7396.8 7481.4 7497.4 4014.3 4019.2 4117.2 4183.3 4321.1 2864.0 3043.3 3069.5 3080.0 3084.5 537.1 540.1 540.6 541.5 543.7 588.5 669.7 680.1 684.9 688.0 9831.0 10015.4 10110.6 10249.3 10377.5 627.8 652.5 674.2 707.4 715.5 4588.8 4875.0 5002.0 5111.8 5317.4 106751.0 117942.0 118052.2 119858.0 122686.0 74742.0 95771.5 96726.5 97530.0 101090.0 83848.6 85440.1 86168.6 86234.0 88286.0 9553.7 9811.1 9898.8 9972.6 10009.3 51032.5 51382.5 51442.0 51933.2 52054.7 59733.7 61344.0 62750.0 68467.7 68648.0 13463.9 13603.0 13627.0 13672.7 13869.6 14724.8 15129.6 15207.4 15472.7 15907.7 13136.0 13185.1 13226.8 13238.6 13838.4 14214.7 14220.4 14351.0 14533.8 14856.1 13405.1 13520.0 13970.3 13977.5 14232.0 11409.7 11646.6 11719.2 11980.9 12111.9 11701.6 11756.8 11805.2 11863.0 11909.2 00:22:47 INFO - PROCESS | 3804 | -------- Summary: end -------- 00:22:47 INFO - PROCESS | 3804 | 00:22:48 INFO - TEST-INFO | 3804: exit 0 00:22:48 INFO - TEST-OK | dromaeo_css | took 1114430ms 00:22:48 INFO - TEST-START | kraken 00:22:48 INFO - operating with platform_type : w7_ 00:22:48 INFO - Initialising browser for kraken test... 00:22:48 INFO - TEST-INFO | started process 1124 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpcrp497\profile http://localhost:49893/getInfo.html) 00:22:54 INFO - PROCESS | 1124 | __metrics Screen width/height:1600/1200 00:22:54 INFO - PROCESS | 1124 | colorDepth:24 00:22:54 INFO - PROCESS | 1124 | Browser inner width/height: 1010/674 00:22:54 INFO - PROCESS | 1124 | __metrics 00:22:55 ERROR - PROCESS | 1124 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 00:22:55 INFO - PROCESS | 1124 | [Child 1220] WARNING: pipe error: 109: file c:/builds/moz2_slave/autoland-w32-pgo-0000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 00:22:55 INFO - PROCESS | 1124 | console.error: 00:22:55 INFO - PROCESS | 1124 | Message: Error: Connection closed before committing the transaction. 00:22:55 INFO - PROCESS | 1124 | Stack: 00:22:55 INFO - PROCESS | 1124 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 00:22:55 INFO - PROCESS | 1124 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 00:22:55 INFO - PROCESS | 1124 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 00:22:55 INFO - PROCESS | 1124 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 00:22:55 INFO - PROCESS | 1124 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 00:22:55 INFO - PROCESS | 1124 | TaskImpl_run@resource://gre/modules/Task.jsm:324:13 00:22:55 INFO - PROCESS | 1124 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 00:22:55 INFO - PROCESS | 1124 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 00:22:55 INFO - PROCESS | 1124 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 00:22:55 INFO - PROCESS | 1124 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 00:22:55 INFO - PROCESS | 1124 | Barrier/this.client.addBlocker/promise13.4% 00:23:54 INFO - TinderboxPrint: I/O read bytes / time
75,254,784 / 891,760 00:23:54 INFO - TinderboxPrint: I/O write bytes / time
554,610,688 / 3,330,210 00:23:54 INFO - TinderboxPrint: CPU idle
8,198.5 (86.6%) 00:23:54 INFO - TinderboxPrint: CPU user
1,222.5 (12.9%) 00:23:54 INFO - install - Wall time: 3s; CPU: 11.0%; Read bytes: 0; Write bytes: 40834560; Read time: 0; Write time: 264860 00:23:54 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 75254784; Write bytes: 482146816; Read time: 891760; Write time: 3037980 00:23:54 INFO - Running post-run listener: _upload_blobber_files 00:23:54 INFO - Blob upload gear active. 00:23:54 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 00:23:54 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 00:23:54 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Autoland', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 00:23:54 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Autoland -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 00:23:55 INFO - (blobuploader) - INFO - Open directory for files ... 00:23:55 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_errorsummary.log ... 00:23:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:23:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:23:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:23:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:23:56 INFO - (blobuploader) - INFO - Done attempting. 00:23:56 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_raw.log ... 00:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:23:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:23:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:23:56 INFO - (blobuploader) - INFO - Done attempting. 00:23:56 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 00:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:24:04 INFO - (blobuploader) - INFO - Done attempting. 00:24:04 INFO - (blobuploader) - INFO - Iteration through files over. 00:24:04 INFO - Return code: 0 00:24:04 INFO - rmtree: C:\slave\test\build\uploaded_files.json 00:24:04 INFO - Using _rmtree_windows ... 00:24:04 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 00:24:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/864a43ff7212c616e2deb3dce5783e0c1f47c225f8482be4cfce80defed62616e05bd5a2ea0b54991c791b8e59e073ce7cfe483c8f0f97cc5189cbb8397a2b7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/90469f2cab65314cc782d0957acbbda4e31a91f68b9fc5f06d3545eb00a8ec8bb8fb7a8ab28e02b8a67a5481d756ae1e111f121ff618ff3efa2a04c1b7ee686e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9937062522797bf6084628740b8736d925dc3538b8ef9a939e52c005c27aa70441725edf3a163b4c708d081146c2f8c84e52c80aa2eb1712376efc3b8743cb28"} 00:24:04 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 00:24:04 INFO - Writing to file C:\slave\test\properties\blobber_files 00:24:04 INFO - Contents: 00:24:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/864a43ff7212c616e2deb3dce5783e0c1f47c225f8482be4cfce80defed62616e05bd5a2ea0b54991c791b8e59e073ce7cfe483c8f0f97cc5189cbb8397a2b7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/90469f2cab65314cc782d0957acbbda4e31a91f68b9fc5f06d3545eb00a8ec8bb8fb7a8ab28e02b8a67a5481d756ae1e111f121ff618ff3efa2a04c1b7ee686e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9937062522797bf6084628740b8736d925dc3538b8ef9a939e52c005c27aa70441725edf3a163b4c708d081146c2f8c84e52c80aa2eb1712376efc3b8743cb28"} 00:24:04 INFO - Running post-run listener: copy_logs_to_upload_dir 00:24:04 INFO - Copying logs to upload dir... 00:24:04 INFO - mkdir: C:\slave\test\build\upload\logs 00:24:04 INFO - Copying logs to upload dir... 00:24:04 INFO - Using _rmtree_windows ... 00:24:04 INFO - Using _rmtree_windows ... 00:24:04 INFO - Using _rmtree_windows ... 00:24:04 INFO - Using _rmtree_windows ... 00:24:04 INFO - Using _rmtree_windows ... 00:24:04 INFO - Using _rmtree_windows ... 00:24:04 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1395.574000 ========= master_lag: 0.00 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 15 secs) (at 2016-09-28 00:24:04.790220) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 00:24:04.791144) ========= '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\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-009 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-009 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-009 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/864a43ff7212c616e2deb3dce5783e0c1f47c225f8482be4cfce80defed62616e05bd5a2ea0b54991c791b8e59e073ce7cfe483c8f0f97cc5189cbb8397a2b7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/90469f2cab65314cc782d0957acbbda4e31a91f68b9fc5f06d3545eb00a8ec8bb8fb7a8ab28e02b8a67a5481d756ae1e111f121ff618ff3efa2a04c1b7ee686e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9937062522797bf6084628740b8736d925dc3538b8ef9a939e52c005c27aa70441725edf3a163b4c708d081146c2f8c84e52c80aa2eb1712376efc3b8743cb28"} build_url:https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/b8AXTtGlTXGRfe5ID4xh8w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/864a43ff7212c616e2deb3dce5783e0c1f47c225f8482be4cfce80defed62616e05bd5a2ea0b54991c791b8e59e073ce7cfe483c8f0f97cc5189cbb8397a2b7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/90469f2cab65314cc782d0957acbbda4e31a91f68b9fc5f06d3545eb00a8ec8bb8fb7a8ab28e02b8a67a5481d756ae1e111f121ff618ff3efa2a04c1b7ee686e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9937062522797bf6084628740b8736d925dc3538b8ef9a939e52c005c27aa70441725edf3a163b4c708d081146c2f8c84e52c80aa2eb1712376efc3b8743cb28"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 00:24:04.905113) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 00:24:04.905455) ========= '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\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-009 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-009 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-009 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 00:24:05.016649) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-09-28 00:24:05.016966) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-09-28 00:24:05.362657) ========= ========= Total master_lag: 0.11 =========