builder: fx-team_win7-ix_test-dromaeojs slave: t-w732-ix-003 starttime: 1445888836.51 results: success (0) buildid: 20151026104938 builduid: 9f42765b126440598b647377741c42dc revision: b842ef4420f1b247ab9706ce8d5028c8bca52ecd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-26 12:47:16.505829) ========= master: http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-26 12:47:16.513416) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2015-10-26 12:47:16.513753) ========= 'cd' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['cd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-003 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-003 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-003 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 C:\slave\test program finished with exit code 0 elapsedTime=1.329000 basedir: 'C:\\slave\\test' ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2015-10-26 12:47:19.089235) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-26 12:47:19.089584) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-26 12:47:19.299341) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-10-26 12:47:19.299857) ========= 'rm' '-rf' 'properties' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-003 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-003 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-003 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=1.401000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-10-26 12:47:20.846855) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-26 12:47:20.847161) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-26 12:47:20.847545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-10-26 12:47:20.847821) ========= '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-003 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-003 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-003 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 --12:47:22-- 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. HTTP request sent, awaiting response... 200 Script output follows Length: 12,141 (12K) [text/x-python] 0K .......... . 100% 7.88 MB/s 12:47:23 (7.88 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=3.042000 ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-10-26 12:47:23.927105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 17 secs) (at 2015-10-26 12:47:23.927443) ========= 'rm' '-rf' 'scripts' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-003 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-003 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-003 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=17.312000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 17 secs) (at 2015-10-26 12:47:41.307885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-26 12:47:41.308260) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev b842ef4420f1b247ab9706ce8d5028c8bca52ecd --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b842ef4420f1b247ab9706ce8d5028c8bca52ecd --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-003 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-003 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-003 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 2015-10-26 12:47:41,446 truncating revision to first 12 chars 2015-10-26 12:47:41,446 Setting DEBUG logging. 2015-10-26 12:47:41,446 attempt 1/10 2015-10-26 12:47:41,447 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b842ef4420f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-26 12:47:42,746 unpacking tar archive at: fx-team-b842ef4420f1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.496000 ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-26 12:47:44.171022) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-26 12:47:44.171362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-26 12:47:45.101913) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-26 12:47:45.102547) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-26 12:47:45.103423) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 33 secs) (at 2015-10-26 12:47:45.103950) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Fx-Team-Non-PGO' '--system-bits' '32' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Fx-Team-Non-PGO' in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '32', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-003 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-003 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-003 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 12:47:45 INFO - MultiFileLogger online at 20151026 12:47:45 in C:\slave\test 12:47:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 32 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:47:45 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 12:47:45 INFO - {'append_to_log': False, 12:47:45 INFO - 'base_work_dir': 'C:\\slave\\test', 12:47:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:47:45 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 12:47:45 INFO - 'branch': 'Fx-Team-Non-PGO', 12:47:45 INFO - 'buildbot_json_path': 'buildprops.json', 12:47:45 INFO - 'config_files': ('talos/windows_config.py',), 12:47:45 INFO - 'default_actions': ('clobber', 12:47:45 INFO - 'read-buildbot-config', 12:47:45 INFO - 'download-and-extract', 12:47:45 INFO - 'populate-webroot', 12:47:45 INFO - 'create-virtualenv', 12:47:45 INFO - 'install', 12:47:45 INFO - 'run-tests'), 12:47:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:47:45 INFO - 'download_minidump_stackwalk': True, 12:47:45 INFO - 'download_symbols': 'ondemand', 12:47:45 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 12:47:45 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 12:47:45 INFO - 'hg': 'c:/mozilla-build/hg/hg', 12:47:45 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 12:47:45 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 12:47:45 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 12:47:45 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 12:47:45 INFO - 'C:/mozilla-build/tooltool.py'), 12:47:45 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 12:47:45 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 12:47:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:47:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:47:45 INFO - 'installer_path': 'installer.exe', 12:47:45 INFO - 'log_level': 'info', 12:47:45 INFO - 'log_name': 'talos', 12:47:45 INFO - 'log_to_console': True, 12:47:45 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 12:47:45 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 12:47:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 12:47:45 INFO - 'opt_config_files': (), 12:47:45 INFO - 'pip_index': False, 12:47:45 INFO - 'sps_profile': False, 12:47:45 INFO - 'sps_profile_interval': 0, 12:47:45 INFO - 'suite': 'dromaeojs', 12:47:45 INFO - 'system_bits': '32', 12:47:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:47:45 INFO - 'title': 'T-W732-IX-003', 12:47:45 INFO - 'use_talos_json': True, 12:47:45 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 12:47:45 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 12:47:45 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 12:47:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:47:45 INFO - 'work_dir': 'build'} 12:47:45 INFO - ##### 12:47:45 INFO - ##### Running clobber step. 12:47:45 INFO - ##### 12:47:45 INFO - Running pre-action listener: _resource_record_pre_action 12:47:45 INFO - Running main action method: clobber 12:47:45 INFO - rmtree: C:\slave\test\build 12:47:45 INFO - Using _rmtree_windows ... 12:47:45 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 12:49:00 INFO - Running post-action listener: _resource_record_post_action 12:49:00 INFO - ##### 12:49:00 INFO - ##### Running read-buildbot-config step. 12:49:00 INFO - ##### 12:49:00 INFO - Running pre-action listener: _resource_record_pre_action 12:49:00 INFO - Running main action method: read_buildbot_config 12:49:00 INFO - Using buildbot properties: 12:49:00 INFO - { 12:49:00 INFO - "properties": { 12:49:00 INFO - "buildnumber": 660, 12:49:00 INFO - "product": "firefox", 12:49:00 INFO - "script_repo_revision": "production", 12:49:00 INFO - "builddir": "fx-team_win7-ix_test-dromaeojs", 12:49:00 INFO - "repository": "", 12:49:00 INFO - "buildername": "Windows 7 32-bit fx-team talos dromaeojs", 12:49:00 INFO - "buildid": "20151026104938", 12:49:00 INFO - "slavename": "t-w732-ix-003", 12:49:00 INFO - "pgo_build": "False", 12:49:00 INFO - "basedir": "C:\\slave\\test", 12:49:00 INFO - "project": "", 12:49:00 INFO - "platform": "win7-ix", 12:49:00 INFO - "master": "http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/", 12:49:00 INFO - "slavebuilddir": "test", 12:49:00 INFO - "scheduler": "tests-fx-team-win32-talos", 12:49:00 INFO - "branch": "fx-team", 12:49:00 INFO - "repo_path": "integration/fx-team", 12:49:00 INFO - "stage_platform": "win32", 12:49:00 INFO - "builduid": "9f42765b126440598b647377741c42dc", 12:49:00 INFO - "revision": "b842ef4420f1b247ab9706ce8d5028c8bca52ecd" 12:49:00 INFO - }, 12:49:00 INFO - "sourcestamp": { 12:49:00 INFO - "repository": "", 12:49:00 INFO - "hasPatch": false, 12:49:00 INFO - "project": "", 12:49:00 INFO - "branch": "fx-team-win32-talos", 12:49:00 INFO - "changes": [ 12:49:00 INFO - { 12:49:00 INFO - "category": null, 12:49:00 INFO - "files": [ 12:49:00 INFO - { 12:49:00 INFO - "url": null, 12:49:00 INFO - "name": "https://queue.taskcluster.net/v1/task/j6yzkpAYREaZBZo-YRSW1Q/artifacts/public/build/firefox-44.0a1.en-US.win32.zip" 12:49:00 INFO - } 12:49:00 INFO - ], 12:49:00 INFO - "repository": "", 12:49:00 INFO - "rev": "c0732e791208246759d0258a6beca9b11842442d", 12:49:00 INFO - "who": "apoirot@mozilla.com", 12:49:00 INFO - "when": 1445887819, 12:49:00 INFO - "number": 6575547, 12:49:00 INFO - "comments": "Bug 1007061 - Remove app-manager. r=jryans", 12:49:00 INFO - "project": "", 12:49:00 INFO - "at": "Mon 26 Oct 2015 12:30:19", 12:49:00 INFO - "branch": "fx-team-win32-talos", 12:49:00 INFO - "revlink": "", 12:49:00 INFO - "properties": [ 12:49:00 INFO - [ 12:49:00 INFO - "buildid", 12:49:00 INFO - "20151026103926", 12:49:00 INFO - "Change" 12:49:00 INFO - ], 12:49:00 INFO - [ 12:49:00 INFO - "builduid", 12:49:00 INFO - "68c5cbb75e0646c1accc88c9d7bad5c0", 12:49:00 INFO - "Change" 12:49:00 INFO - ], 12:49:00 INFO - [ 12:49:00 INFO - "pgo_build", 12:49:00 INFO - "False", 12:49:00 INFO - "Change" 12:49:00 INFO - ] 12:49:00 INFO - ], 12:49:00 INFO - "revision": "c0732e791208246759d0258a6beca9b11842442d" 12:49:00 INFO - }, 12:49:00 INFO - { 12:49:00 INFO - "category": null, 12:49:00 INFO - "files": [ 12:49:00 INFO - { 12:49:00 INFO - "url": null, 12:49:00 INFO - "name": "https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip" 12:49:00 INFO - } 12:49:00 INFO - ], 12:49:00 INFO - "repository": "", 12:49:00 INFO - "rev": "b842ef4420f1b247ab9706ce8d5028c8bca52ecd", 12:49:00 INFO - "who": "apoirot@mozilla.com", 12:49:00 INFO - "when": 1445887206, 12:49:00 INFO - "number": 6575430, 12:49:00 INFO - "comments": "Bug 1213011 - Use stable file name for simulator xpi in TC. r=garndt", 12:49:00 INFO - "project": "", 12:49:00 INFO - "at": "Mon 26 Oct 2015 12:20:06", 12:49:00 INFO - "branch": "fx-team-win32-talos", 12:49:00 INFO - "revlink": "", 12:49:00 INFO - "properties": [ 12:49:00 INFO - [ 12:49:00 INFO - "buildid", 12:49:00 INFO - "20151026104938", 12:49:00 INFO - "Change" 12:49:00 INFO - ], 12:49:00 INFO - [ 12:49:00 INFO - "builduid", 12:49:00 INFO - "9f42765b126440598b647377741c42dc", 12:49:00 INFO - "Change" 12:49:00 INFO - ], 12:49:00 INFO - [ 12:49:00 INFO - "pgo_build", 12:49:00 INFO - "False", 12:49:00 INFO - "Change" 12:49:00 INFO - ] 12:49:00 INFO - ], 12:49:00 INFO - "revision": "b842ef4420f1b247ab9706ce8d5028c8bca52ecd" 12:49:00 INFO - } 12:49:00 INFO - ], 12:49:00 INFO - "revision": "b842ef4420f1b247ab9706ce8d5028c8bca52ecd" 12:49:00 INFO - } 12:49:00 INFO - } 12:49:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip. 12:49:00 INFO - Running post-action listener: _resource_record_post_action 12:49:00 INFO - ##### 12:49:00 INFO - ##### Running download-and-extract step. 12:49:00 INFO - ##### 12:49:00 INFO - Running pre-action listener: _resource_record_pre_action 12:49:00 INFO - Running main action method: download_and_extract 12:49:00 INFO - mkdir: C:\slave\test\build\tests 12:49:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:00 INFO - https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:49:01 INFO - trying https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/test_packages.json 12:49:01 INFO - Downloading https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 12:49:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1 12:49:02 INFO - Downloaded 1221 bytes. 12:49:02 INFO - Reading from file C:\slave\test\build\test_packages.json 12:49:02 INFO - Using the following test package requirements: 12:49:02 INFO - {u'common': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 12:49:02 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 12:49:02 INFO - u'firefox-44.0a1.en-US.win32.cppunittest.tests.zip'], 12:49:02 INFO - u'jittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 12:49:02 INFO - u'jsshell-win32.zip'], 12:49:02 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 12:49:02 INFO - u'firefox-44.0a1.en-US.win32.mochitest.tests.zip'], 12:49:02 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 12:49:02 INFO - u'reftest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 12:49:02 INFO - u'firefox-44.0a1.en-US.win32.reftest.tests.zip'], 12:49:02 INFO - u'talos': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 12:49:02 INFO - u'firefox-44.0a1.en-US.win32.talos.tests.zip'], 12:49:02 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 12:49:02 INFO - u'firefox-44.0a1.en-US.win32.web-platform.tests.zip'], 12:49:02 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 12:49:02 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 12:49:02 INFO - u'firefox-44.0a1.en-US.win32.xpcshell.tests.zip']} 12:49:02 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip'] for test suite category: common 12:49:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:02 INFO - https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 12:49:02 INFO - trying https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 12:49:02 INFO - Downloading https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip 12:49:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'}, attempt #1 12:49:09 INFO - Downloaded 18012884 bytes. 12:49:09 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] in C:\slave\test\build\tests 12:49:09 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip 12:49:09 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 12:49:38 INFO - Return code: 0 12:49:38 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip', u'firefox-44.0a1.en-US.win32.talos.tests.zip'] for test suite category: talos 12:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:38 INFO - https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 12:49:38 INFO - trying https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 12:49:38 INFO - Downloading https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip 12:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'}, attempt #1 12:49:44 INFO - Downloaded 18012884 bytes. 12:49:44 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] in C:\slave\test\build\tests 12:49:44 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip 12:49:44 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 12:50:07 INFO - Return code: 0 12:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:07 INFO - https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip matches https://queue.taskcluster.net 12:50:07 INFO - trying https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip 12:50:07 INFO - Downloading https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.talos.tests.zip 12:50:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'}, attempt #1 12:50:21 INFO - Downloaded 11131307 bytes. 12:50:21 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] in C:\slave\test\build\tests 12:50:21 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win32.talos.tests.zip 12:50:21 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] with output_timeout 1760 12:50:22 INFO - Return code: 0 12:50:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:22 INFO - https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip matches https://queue.taskcluster.net 12:50:22 INFO - trying https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 12:50:22 INFO - Downloading https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.zip 12:50:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.zip'}, attempt #1 12:50:26 INFO - Downloaded 51446639 bytes. 12:50:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 12:50:26 INFO - mkdir: C:\slave\test\properties 12:50:26 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 12:50:26 INFO - Writing to file C:\slave\test\properties\build_url 12:50:26 INFO - Contents: 12:50:26 INFO - build_url:https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 12:50:26 INFO - Running post-action listener: _resource_record_post_action 12:50:26 INFO - Running post-action listener: set_extra_try_arguments 12:50:26 INFO - ##### 12:50:26 INFO - ##### Running populate-webroot step. 12:50:26 INFO - ##### 12:50:26 INFO - Running pre-action listener: _resource_record_pre_action 12:50:26 INFO - Running main action method: populate_webroot 12:50:26 INFO - Guessing talos json url... 12:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:26 INFO - https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.txt matches https://queue.taskcluster.net 12:50:26 INFO - trying https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.txt 12:50:26 INFO - Downloading https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.txt to C:\slave\test\build\firefox-44.0a1.en-US.win32.txt 12:50:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.txt', 'file_name': 'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.txt'}, attempt #1 12:50:27 INFO - Downloaded 103 bytes. 12:50:27 INFO - Reading from file C:\slave\test\build\firefox-44.0a1.en-US.win32.txt 12:50:27 INFO - Contents: 12:50:27 INFO - 20151026104938 12:50:27 INFO - https://hg.mozilla.org/integration/fx-team/rev/b842ef4420f1b247ab9706ce8d5028c8bca52ecd 12:50:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:27 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/b842ef4420/testing/talos/talos.json 12:50:27 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/b842ef4420/testing/talos/talos.json to C:\slave\test\build\talos.json 12:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/b842ef4420/testing/talos/talos.json', 'file_name': 'C:\\slave\\test\\build\\talos.json'}, attempt #1 12:50:28 INFO - Downloaded 4264 bytes. 12:50:28 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 12:50:28 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 12:50:28 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 12:50:28 INFO - u'../fennec_ids.txt'], 12:50:28 INFO - u'tests': [u'tcheck2']}, 12:50:28 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 12:50:28 INFO - u'--tppagecycles', 12:50:28 INFO - u'7'], 12:50:28 INFO - u'tests': [u'tsvgm']}}, 12:50:28 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 12:50:28 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 12:50:28 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 12:50:28 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 12:50:28 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 12:50:28 INFO - u'tests': [u'dromaeo_css', 12:50:28 INFO - u'kraken', 12:50:28 INFO - u'v8_7']}, 12:50:28 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:28 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 12:50:28 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:28 INFO - u'talos_options': [u'--e10s'], 12:50:28 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 12:50:28 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:28 INFO - u'tests': [u'damp', u'tps']}, 12:50:28 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:28 INFO - u'talos_options': [u'--e10s'], 12:50:28 INFO - u'tests': [u'damp', u'tps']}, 12:50:28 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 12:50:28 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 12:50:28 INFO - u'other': {u'tests': [u'a11yr', 12:50:28 INFO - u'ts_paint', 12:50:28 INFO - u'tpaint', 12:50:28 INFO - u'sessionrestore', 12:50:28 INFO - u'sessionrestore_no_auto_restore']}, 12:50:28 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 12:50:28 INFO - u'tests': [u'a11yr', 12:50:28 INFO - u'ts_paint', 12:50:28 INFO - u'tpaint', 12:50:28 INFO - u'sessionrestore', 12:50:28 INFO - u'sessionrestore_no_auto_restore']}, 12:50:28 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 12:50:28 INFO - u'tests': [u'a11yr', 12:50:28 INFO - u'ts_paint', 12:50:28 INFO - u'tpaint', 12:50:28 INFO - u'sessionrestore', 12:50:28 INFO - u'sessionrestore_no_auto_restore']}, 12:50:28 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 12:50:28 INFO - u'tests': [u'a11yr', 12:50:28 INFO - u'ts_paint', 12:50:28 INFO - u'tpaint', 12:50:28 INFO - u'sessionrestore', 12:50:28 INFO - u'sessionrestore_no_auto_restore']}, 12:50:28 INFO - u'other_l64': {u'tests': [u'a11yr', 12:50:28 INFO - u'ts_paint', 12:50:28 INFO - u'tpaint', 12:50:28 INFO - u'sessionrestore', 12:50:28 INFO - u'sessionrestore_no_auto_restore']}, 12:50:28 INFO - u'other_nol64': {u'tests': [u'a11yr', 12:50:28 INFO - u'ts_paint', 12:50:28 INFO - u'tpaint', 12:50:28 INFO - u'sessionrestore', 12:50:28 INFO - u'sessionrestore_no_auto_restore']}, 12:50:28 INFO - u'svgr': {u'tests': [u'tsvgx', 12:50:28 INFO - u'tsvgr_opacity', 12:50:28 INFO - u'tart', 12:50:28 INFO - u'tscrollx', 12:50:28 INFO - u'cart']}, 12:50:28 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 12:50:28 INFO - u'tests': [u'tsvgx', 12:50:28 INFO - u'tsvgr_opacity', 12:50:28 INFO - u'tart', 12:50:28 INFO - u'tscrollx', 12:50:28 INFO - u'cart']}, 12:50:28 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:28 INFO - u'tests': [u'tp5o']}, 12:50:28 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:28 INFO - u'talos_options': [u'--e10s'], 12:50:28 INFO - u'tests': [u'tp5o']}, 12:50:28 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:28 INFO - u'talos_options': [u'--xperf_path', 12:50:28 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:28 INFO - u'tests': [u'tp5n']}, 12:50:28 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:28 INFO - u'talos_options': [u'--e10s', 12:50:28 INFO - u'--xperf_path', 12:50:28 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 12:50:28 INFO - u'C:/slave/talos-data/talos/xperf.config'], 12:50:28 INFO - u'tests': [u'tp5n']}}, 12:50:28 INFO - u'talos.zip': {u'path': u'', 12:50:28 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:50:28 INFO - Running post-action listener: _resource_record_post_action 12:50:28 INFO - ##### 12:50:28 INFO - ##### Running create-virtualenv step. 12:50:28 INFO - ##### 12:50:28 INFO - Running pre-action listener: _resource_record_pre_action 12:50:28 INFO - Running main action method: create_virtualenv 12:50:28 INFO - Creating virtualenv C:\slave\test\build/venv 12:50:28 INFO - mkdir: C:\slave\test\build\venv\Scripts 12:50:28 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 12:50:28 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'! 12:50:28 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 12:50:28 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 12:50:31 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 12:50:36 INFO - Installing distribute......................................................................................................................................................................................done. 12:50:38 INFO - Return code: 0 12:50:38 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 12:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:38 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--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 0x01863B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01780680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01278B48>, '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 0x0129A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01EAF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-003', 'USERDOMAIN': 'T-W732-IX-003', '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-003', '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 12:50:38 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--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 12:50:38 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --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 12:50:38 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:50:38 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 12:50:38 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 12:50:38 INFO - 'COMPUTERNAME': 'T-W732-IX-003', 12:50:38 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:50:38 INFO - 'CYGWINBASE': 'C:\\cygwin', 12:50:38 INFO - 'DCLOCATION': 'SCL3', 12:50:38 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:50:38 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:50:38 INFO - 'HOMEDRIVE': 'C:', 12:50:38 INFO - 'HOMEPATH': '\\Users\\cltbld', 12:50:38 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:50:38 INFO - 'KTS_VERSION': '1.19c', 12:50:38 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 12:50:38 INFO - 'LOGONSERVER': '\\\\T-W732-IX-003', 12:50:38 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:50:38 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:38 INFO - 'MOZ_NO_REMOTE': '1', 12:50:38 INFO - 'NO_EM_RESTART': '1', 12:50:38 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:50:38 INFO - 'OS': 'Windows_NT', 12:50:38 INFO - 'OURDRIVE': 'C:', 12:50:38 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;', 12:50:38 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:50:38 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:50:38 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 12:50:38 INFO - 'PROCESSOR_LEVEL': '6', 12:50:38 INFO - 'PROCESSOR_REVISION': '1e05', 12:50:38 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:50:38 INFO - 'PROGRAMFILES': 'C:\\Program Files', 12:50:38 INFO - 'PROMPT': '$P$G', 12:50:38 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:50:38 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:50:38 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:50:38 INFO - 'PWD': 'C:\\slave\\test', 12:50:38 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:50:38 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:50:38 INFO - 'SYSTEMDRIVE': 'C:', 12:50:38 INFO - 'SYSTEMROOT': 'C:\\windows', 12:50:38 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:50:38 INFO - 'TEST1': 'testie', 12:50:38 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:50:38 INFO - 'USERDOMAIN': 'T-W732-IX-003', 12:50:38 INFO - 'USERNAME': 'cltbld', 12:50:38 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 12:50:38 INFO - 'WINDIR': 'C:\\windows', 12:50:38 INFO - 'WINDOWS_TRACING_FLAGS': '3', 12:50:38 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 12:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:50:43 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:50:43 INFO - Downloading/unpacking pip>=1.5 12:50:43 INFO - Creating supposed download cache at C:\slave\test\build/venv\cache 12:50:48 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz 12:50:48 INFO - Running setup.py egg_info for package pip 12:50:48 INFO - warning: no files found matching 'pip\cacert.pem' 12:50:48 INFO - warning: no files found matching '*.html' under directory 'docs' 12:50:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 12:50:48 INFO - no previously-included directories found matching 'docs\_build\_sources' 12:50:48 INFO - Installing collected packages: pip 12:50:48 INFO - Found existing installation: pip 0.8.2 12:50:48 INFO - Uninstalling pip: 12:50:48 INFO - Successfully uninstalled pip 12:50:48 INFO - Running setup.py install for pip 12:50:48 INFO - warning: no files found matching 'pip\cacert.pem' 12:50:48 INFO - warning: no files found matching '*.html' under directory 'docs' 12:50:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 12:50:48 INFO - no previously-included directories found matching 'docs\_build\_sources' 12:50:48 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 12:50:48 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 12:50:48 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 12:50:48 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 12:50:48 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 12:50:48 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 12:50:48 INFO - Successfully installed pip 12:50:48 INFO - Cleaning up... 12:50:48 INFO - Return code: 0 12:50:48 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build/venv 12:50:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:48 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01863B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01780680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01278B48>, '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 0x0129A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01EAF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-003', 'USERDOMAIN': 'T-W732-IX-003', '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-003', '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 12:50:48 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in C:\slave\test\build 12:50:48 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:50:48 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:50:48 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 12:50:48 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 12:50:48 INFO - 'COMPUTERNAME': 'T-W732-IX-003', 12:50:48 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:50:48 INFO - 'CYGWINBASE': 'C:\\cygwin', 12:50:48 INFO - 'DCLOCATION': 'SCL3', 12:50:48 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:50:48 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:50:48 INFO - 'HOMEDRIVE': 'C:', 12:50:48 INFO - 'HOMEPATH': '\\Users\\cltbld', 12:50:48 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:50:48 INFO - 'KTS_VERSION': '1.19c', 12:50:48 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 12:50:48 INFO - 'LOGONSERVER': '\\\\T-W732-IX-003', 12:50:48 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:50:48 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:48 INFO - 'MOZ_NO_REMOTE': '1', 12:50:48 INFO - 'NO_EM_RESTART': '1', 12:50:48 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:50:48 INFO - 'OS': 'Windows_NT', 12:50:48 INFO - 'OURDRIVE': 'C:', 12:50:48 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;', 12:50:48 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:50:48 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:50:48 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 12:50:48 INFO - 'PROCESSOR_LEVEL': '6', 12:50:48 INFO - 'PROCESSOR_REVISION': '1e05', 12:50:48 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:50:48 INFO - 'PROGRAMFILES': 'C:\\Program Files', 12:50:48 INFO - 'PROMPT': '$P$G', 12:50:48 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:50:48 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:50:48 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:50:48 INFO - 'PWD': 'C:\\slave\\test', 12:50:48 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:50:48 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:50:48 INFO - 'SYSTEMDRIVE': 'C:', 12:50:48 INFO - 'SYSTEMROOT': 'C:\\windows', 12:50:48 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:50:48 INFO - 'TEST1': 'testie', 12:50:48 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:50:48 INFO - 'USERDOMAIN': 'T-W732-IX-003', 12:50:48 INFO - 'USERNAME': 'cltbld', 12:50:48 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 12:50:48 INFO - 'WINDIR': 'C:\\windows', 12:50:48 INFO - 'WINDOWS_TRACING_FLAGS': '3', 12:50:48 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 12:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:50 INFO - Downloading/unpacking psutil>=0.7.1 12:50:50 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 12:50:50 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 12:50:52 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpsutil-3.1.1-cp27-none-win32.whl 12:50:52 INFO - Installing collected packages: psutil 12:50:52 INFO - Successfully installed psutil 12:50:52 INFO - Cleaning up... 12:50:52 INFO - Return code: 0 12:50:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test\build/venv 12:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:52 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01863B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01780680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01278B48>, '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 0x0129A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01EAF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-003', 'USERDOMAIN': 'T-W732-IX-003', '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-003', '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 12:50:52 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in C:\slave\test\build 12:50:52 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:50:52 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:50:52 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 12:50:52 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 12:50:52 INFO - 'COMPUTERNAME': 'T-W732-IX-003', 12:50:52 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:50:52 INFO - 'CYGWINBASE': 'C:\\cygwin', 12:50:52 INFO - 'DCLOCATION': 'SCL3', 12:50:52 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:50:52 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:50:52 INFO - 'HOMEDRIVE': 'C:', 12:50:52 INFO - 'HOMEPATH': '\\Users\\cltbld', 12:50:52 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:50:52 INFO - 'KTS_VERSION': '1.19c', 12:50:52 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 12:50:52 INFO - 'LOGONSERVER': '\\\\T-W732-IX-003', 12:50:52 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:50:52 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:52 INFO - 'MOZ_NO_REMOTE': '1', 12:50:52 INFO - 'NO_EM_RESTART': '1', 12:50:52 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:50:52 INFO - 'OS': 'Windows_NT', 12:50:52 INFO - 'OURDRIVE': 'C:', 12:50:52 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;', 12:50:52 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:50:52 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:50:52 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 12:50:52 INFO - 'PROCESSOR_LEVEL': '6', 12:50:52 INFO - 'PROCESSOR_REVISION': '1e05', 12:50:52 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:50:52 INFO - 'PROGRAMFILES': 'C:\\Program Files', 12:50:52 INFO - 'PROMPT': '$P$G', 12:50:52 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:50:52 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:50:52 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:50:52 INFO - 'PWD': 'C:\\slave\\test', 12:50:52 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:50:52 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:50:52 INFO - 'SYSTEMDRIVE': 'C:', 12:50:52 INFO - 'SYSTEMROOT': 'C:\\windows', 12:50:52 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:50:52 INFO - 'TEST1': 'testie', 12:50:52 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:50:52 INFO - 'USERDOMAIN': 'T-W732-IX-003', 12:50:52 INFO - 'USERNAME': 'cltbld', 12:50:52 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 12:50:52 INFO - 'WINDIR': 'C:\\windows', 12:50:52 INFO - 'WINDOWS_TRACING_FLAGS': '3', 12:50:52 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 12:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:50:55 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmozsystemmonitor-0.0.tar.gz 12:50:55 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 12:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.0.0) 12:50:55 INFO - Installing collected packages: mozsystemmonitor 12:50:55 INFO - Running setup.py install for mozsystemmonitor 12:50:55 INFO - Successfully installed mozsystemmonitor 12:50:55 INFO - Cleaning up... 12:50:56 INFO - Return code: 0 12:50:56 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 12:50:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:56 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--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 0x01863B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01780680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01278B48>, '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 0x0129A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01EAF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-003', 'USERDOMAIN': 'T-W732-IX-003', '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-003', '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 12:50:56 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--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 12:50:56 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --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 12:50:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:50:56 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 12:50:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 12:50:56 INFO - 'COMPUTERNAME': 'T-W732-IX-003', 12:50:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:50:56 INFO - 'CYGWINBASE': 'C:\\cygwin', 12:50:56 INFO - 'DCLOCATION': 'SCL3', 12:50:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:50:56 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:50:56 INFO - 'HOMEDRIVE': 'C:', 12:50:56 INFO - 'HOMEPATH': '\\Users\\cltbld', 12:50:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:50:56 INFO - 'KTS_VERSION': '1.19c', 12:50:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 12:50:56 INFO - 'LOGONSERVER': '\\\\T-W732-IX-003', 12:50:56 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:50:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:56 INFO - 'MOZ_NO_REMOTE': '1', 12:50:56 INFO - 'NO_EM_RESTART': '1', 12:50:56 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:50:56 INFO - 'OS': 'Windows_NT', 12:50:56 INFO - 'OURDRIVE': 'C:', 12:50:56 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;', 12:50:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:50:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:50:56 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 12:50:56 INFO - 'PROCESSOR_LEVEL': '6', 12:50:56 INFO - 'PROCESSOR_REVISION': '1e05', 12:50:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:50:56 INFO - 'PROGRAMFILES': 'C:\\Program Files', 12:50:56 INFO - 'PROMPT': '$P$G', 12:50:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:50:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:50:56 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:50:56 INFO - 'PWD': 'C:\\slave\\test', 12:50:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:50:56 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:50:56 INFO - 'SYSTEMDRIVE': 'C:', 12:50:56 INFO - 'SYSTEMROOT': 'C:\\windows', 12:50:56 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:50:56 INFO - 'TEST1': 'testie', 12:50:56 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:50:56 INFO - 'USERDOMAIN': 'T-W732-IX-003', 12:50:56 INFO - 'USERNAME': 'cltbld', 12:50:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 12:50:56 INFO - 'WINDIR': 'C:\\windows', 12:50:56 INFO - 'WINDOWS_TRACING_FLAGS': '3', 12:50:56 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 12:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:50:56 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 12:50:56 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 12:51:00 INFO - Downloading blobuploader-1.2.4.tar.gz 12:51:00 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblobuploader-1.2.4.tar.gz 12:51:00 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 12:51:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:51:00 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 12:51:00 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 12:51:01 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2frequests-1.2.3.tar.gz 12:51:01 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 12:51:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:02 INFO - Downloading docopt-0.6.1.tar.gz 12:51:02 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fdocopt-0.6.1.tar.gz 12:51:02 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 12:51:02 INFO - Installing collected packages: blobuploader, requests, docopt 12:51:02 INFO - Running setup.py install for blobuploader 12:51:02 INFO - Running setup.py install for requests 12:51:03 INFO - Running setup.py install for docopt 12:51:03 INFO - Successfully installed blobuploader requests docopt 12:51:03 INFO - Cleaning up... 12:51:04 INFO - Return code: 0 12:51:04 INFO - Installing None into virtualenv C:\slave\test\build/venv 12:51:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:04 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--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 0x01863B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01780680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01278B48>, '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 0x0129A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01EAF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-003', 'USERDOMAIN': 'T-W732-IX-003', '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-003', '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 12:51:04 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--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 12:51:04 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --download-cache C:\slave\test\build/venv\cache --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 12:51:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:51:04 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 12:51:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 12:51:04 INFO - 'COMPUTERNAME': 'T-W732-IX-003', 12:51:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:51:04 INFO - 'CYGWINBASE': 'C:\\cygwin', 12:51:04 INFO - 'DCLOCATION': 'SCL3', 12:51:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:51:04 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:51:04 INFO - 'HOMEDRIVE': 'C:', 12:51:04 INFO - 'HOMEPATH': '\\Users\\cltbld', 12:51:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:51:04 INFO - 'KTS_VERSION': '1.19c', 12:51:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 12:51:04 INFO - 'LOGONSERVER': '\\\\T-W732-IX-003', 12:51:04 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:51:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:04 INFO - 'MOZ_NO_REMOTE': '1', 12:51:04 INFO - 'NO_EM_RESTART': '1', 12:51:04 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:51:04 INFO - 'OS': 'Windows_NT', 12:51:04 INFO - 'OURDRIVE': 'C:', 12:51:04 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;', 12:51:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:51:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:51:04 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 12:51:04 INFO - 'PROCESSOR_LEVEL': '6', 12:51:04 INFO - 'PROCESSOR_REVISION': '1e05', 12:51:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:51:04 INFO - 'PROGRAMFILES': 'C:\\Program Files', 12:51:04 INFO - 'PROMPT': '$P$G', 12:51:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:51:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:51:04 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:51:04 INFO - 'PWD': 'C:\\slave\\test', 12:51:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:51:04 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:51:04 INFO - 'SYSTEMDRIVE': 'C:', 12:51:04 INFO - 'SYSTEMROOT': 'C:\\windows', 12:51:04 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:51:04 INFO - 'TEST1': 'testie', 12:51:04 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:51:04 INFO - 'USERDOMAIN': 'T-W732-IX-003', 12:51:04 INFO - 'USERNAME': 'cltbld', 12:51:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 12:51:04 INFO - 'WINDIR': 'C:\\windows', 12:51:04 INFO - 'WINDOWS_TRACING_FLAGS': '3', 12:51:04 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 12:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 12:51:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zo24qq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 12:51:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 12:51:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ko2lzs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 12:51:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 12:51:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-o1nhi4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 12:51:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 12:51:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-a8rrqv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 12:51:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 12:51:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-swi44c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 12:51:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 12:51:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-rqmgjs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 12:51:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 12:51:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vmfajb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 12:51:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 12:51:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-rkiom4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 12:51:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 12:51:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vdncko-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 12:51:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 12:51:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vsxpmj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 12:51:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 12:51:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bn9roh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 12:51:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 12:51:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-7r7cxz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 12:51:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 12:51:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-4hrdon-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 12:51:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 12:51:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-amjcjl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 12:51:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 12:51:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yxveof-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 12:51:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 12:51:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9hyeex-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 12:51:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 12:51:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-fqk0uo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 12:51:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:51:07 INFO - Running setup.py install for manifestparser 12:51:07 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 12:51:07 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 12:51:07 INFO - Running setup.py install for mozcrash 12:51:07 INFO - Running setup.py install for mozdebug 12:51:08 INFO - Running setup.py install for mozdevice 12:51:08 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 12:51:08 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 12:51:08 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 12:51:08 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 12:51:08 INFO - Running setup.py install for mozfile 12:51:09 INFO - Running setup.py install for mozhttpd 12:51:09 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 12:51:09 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 12:51:09 INFO - Running setup.py install for mozinfo 12:51:09 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 12:51:09 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 12:51:09 INFO - Running setup.py install for mozInstall 12:51:10 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 12:51:10 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 12:51:10 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 12:51:10 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 12:51:10 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 12:51:10 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 12:51:10 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 12:51:10 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 12:51:10 INFO - Running setup.py install for mozleak 12:51:10 INFO - Running setup.py install for mozlog 12:51:10 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 12:51:10 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 12:51:11 INFO - Running setup.py install for moznetwork 12:51:11 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 12:51:11 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 12:51:11 INFO - Running setup.py install for mozprocess 12:51:12 INFO - Running setup.py install for mozprofile 12:51:12 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 12:51:12 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 12:51:12 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 12:51:12 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 12:51:12 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 12:51:12 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 12:51:13 INFO - Running setup.py install for mozrunner 12:51:13 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 12:51:13 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 12:51:13 INFO - Running setup.py install for mozscreenshot 12:51:14 INFO - Running setup.py install for moztest 12:51:14 INFO - Running setup.py install for mozversion 12:51:14 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 12:51:14 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 12:51:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:14 INFO - Cleaning up... 12:51:14 INFO - Return code: 0 12:51:14 INFO - Installing None into virtualenv C:\slave\test\build/venv 12:51:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:14 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--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 0x01863B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01780680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01278B48>, '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 0x0129A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01EAF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-003', 'USERDOMAIN': 'T-W732-IX-003', '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-003', '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 12:51:15 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--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 12:51:15 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --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 12:51:15 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:51:15 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 12:51:15 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 12:51:15 INFO - 'COMPUTERNAME': 'T-W732-IX-003', 12:51:15 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:51:15 INFO - 'CYGWINBASE': 'C:\\cygwin', 12:51:15 INFO - 'DCLOCATION': 'SCL3', 12:51:15 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:51:15 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:51:15 INFO - 'HOMEDRIVE': 'C:', 12:51:15 INFO - 'HOMEPATH': '\\Users\\cltbld', 12:51:15 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:51:15 INFO - 'KTS_VERSION': '1.19c', 12:51:15 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 12:51:15 INFO - 'LOGONSERVER': '\\\\T-W732-IX-003', 12:51:15 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:51:15 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:15 INFO - 'MOZ_NO_REMOTE': '1', 12:51:15 INFO - 'NO_EM_RESTART': '1', 12:51:15 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:51:15 INFO - 'OS': 'Windows_NT', 12:51:15 INFO - 'OURDRIVE': 'C:', 12:51:15 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;', 12:51:15 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:51:15 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:51:15 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 12:51:15 INFO - 'PROCESSOR_LEVEL': '6', 12:51:15 INFO - 'PROCESSOR_REVISION': '1e05', 12:51:15 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:51:15 INFO - 'PROGRAMFILES': 'C:\\Program Files', 12:51:15 INFO - 'PROMPT': '$P$G', 12:51:15 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:51:15 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:51:15 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:51:15 INFO - 'PWD': 'C:\\slave\\test', 12:51:15 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:51:15 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:51:15 INFO - 'SYSTEMDRIVE': 'C:', 12:51:15 INFO - 'SYSTEMROOT': 'C:\\windows', 12:51:15 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:51:15 INFO - 'TEST1': 'testie', 12:51:15 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:51:15 INFO - 'USERDOMAIN': 'T-W732-IX-003', 12:51:15 INFO - 'USERNAME': 'cltbld', 12:51:15 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 12:51:15 INFO - 'WINDIR': 'C:\\windows', 12:51:15 INFO - 'WINDOWS_TRACING_FLAGS': '3', 12:51:15 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 12:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 12:51:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-_vupcm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 12:51:15 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)) 12:51:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 12:51:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ykdwr5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 12:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 12:51:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 12:51:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mtn7hg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 12:51:15 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)) 12:51:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 12:51:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ra3yxv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 12:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 12:51:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 12:51:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ywtgwn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 12:51:16 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)) 12:51:16 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 12:51:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-geta4r-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 12:51:16 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)) 12:51:16 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 12:51:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9oh9xg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 12:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 12:51:16 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 12:51:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gv0tdt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 12:51:16 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)) 12:51:16 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 12:51:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mmvcrr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 12:51:16 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)) 12:51:16 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 12:51:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pkw52y-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 12:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 12:51:16 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 12:51:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-id3pzr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 12:51:16 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)) 12:51:16 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 12:51:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nikjuf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 12:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 12:51:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 12:51:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vh5vbr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 12:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 12:51:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 12:51:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-uujigl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 12:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 12:51:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 12:51:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-wktckw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 12:51:17 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)) 12:51:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 12:51:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-oonozt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 12:51:17 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)) 12:51:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 12:51:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-niesi5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 12:51:17 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)) 12:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 12:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 12:51:17 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)) 12:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 12:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 12:51:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 12:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:20 INFO - Downloading blessings-1.5.1.tar.gz 12:51:20 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblessings-1.5.1.tar.gz 12:51:20 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 12:51:20 INFO - Installing collected packages: blessings 12:51:20 INFO - Running setup.py install for blessings 12:51:20 INFO - Successfully installed blessings 12:51:20 INFO - Cleaning up... 12:51:23 INFO - Return code: 0 12:51:23 INFO - Done creating virtualenv C:\slave\test\build/venv. 12:51:23 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 12:51:23 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 12:51:23 INFO - Reading from file tmpfile_stdout 12:51:23 INFO - Using _rmtree_windows ... 12:51:23 INFO - Using _rmtree_windows ... 12:51:23 INFO - Current package versions: 12:51:23 INFO - blessings == 1.5.1 12:51:23 INFO - blobuploader == 1.2.4 12:51:23 INFO - docopt == 0.6.1 12:51:23 INFO - manifestparser == 1.1 12:51:23 INFO - mozInstall == 1.12 12:51:23 INFO - mozcrash == 0.16 12:51:23 INFO - mozdebug == 0.1 12:51:23 INFO - mozdevice == 0.46 12:51:23 INFO - mozfile == 1.2 12:51:23 INFO - mozhttpd == 0.7 12:51:23 INFO - mozinfo == 0.8 12:51:23 INFO - mozleak == 0.1 12:51:23 INFO - mozlog == 3.0 12:51:23 INFO - moznetwork == 0.27 12:51:23 INFO - mozprocess == 0.22 12:51:23 INFO - mozprofile == 0.27 12:51:23 INFO - mozrunner == 6.11 12:51:23 INFO - mozscreenshot == 0.1 12:51:23 INFO - mozsystemmonitor == 0.0 12:51:23 INFO - moztest == 0.7 12:51:23 INFO - mozversion == 1.4 12:51:23 INFO - psutil == 3.1.1 12:51:23 INFO - requests == 1.2.3 12:51:23 INFO - Installing None into virtualenv C:\slave\test\build/venv 12:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:23 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--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 0x01863B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01780680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01278B48>, '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 0x0129A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01EAF660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-003', 'USERDOMAIN': 'T-W732-IX-003', '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-003', '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 12:51:23 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--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 12:51:23 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --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 12:51:23 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:51:23 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 12:51:23 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 12:51:23 INFO - 'COMPUTERNAME': 'T-W732-IX-003', 12:51:23 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:51:23 INFO - 'CYGWINBASE': 'C:\\cygwin', 12:51:23 INFO - 'DCLOCATION': 'SCL3', 12:51:23 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:51:23 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:51:23 INFO - 'HOMEDRIVE': 'C:', 12:51:23 INFO - 'HOMEPATH': '\\Users\\cltbld', 12:51:23 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:51:23 INFO - 'KTS_VERSION': '1.19c', 12:51:23 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 12:51:23 INFO - 'LOGONSERVER': '\\\\T-W732-IX-003', 12:51:23 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:51:23 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:23 INFO - 'MOZ_NO_REMOTE': '1', 12:51:23 INFO - 'NO_EM_RESTART': '1', 12:51:23 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:51:23 INFO - 'OS': 'Windows_NT', 12:51:23 INFO - 'OURDRIVE': 'C:', 12:51:23 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;', 12:51:23 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:51:23 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:51:23 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 12:51:23 INFO - 'PROCESSOR_LEVEL': '6', 12:51:23 INFO - 'PROCESSOR_REVISION': '1e05', 12:51:23 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:51:23 INFO - 'PROGRAMFILES': 'C:\\Program Files', 12:51:23 INFO - 'PROMPT': '$P$G', 12:51:23 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:51:23 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:51:23 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:51:23 INFO - 'PWD': 'C:\\slave\\test', 12:51:23 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:51:23 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:51:23 INFO - 'SYSTEMDRIVE': 'C:', 12:51:23 INFO - 'SYSTEMROOT': 'C:\\windows', 12:51:23 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:51:23 INFO - 'TEST1': 'testie', 12:51:23 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:51:23 INFO - 'USERDOMAIN': 'T-W732-IX-003', 12:51:23 INFO - 'USERNAME': 'cltbld', 12:51:23 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 12:51:23 INFO - 'WINDIR': 'C:\\windows', 12:51:23 INFO - 'WINDOWS_TRACING_FLAGS': '3', 12:51:23 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 12:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:24 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 1)) 12:51:24 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 2)) 12:51:24 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 3)) 12:51:24 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 4)) 12:51:24 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 5)) 12:51:24 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 6)) 12:51:24 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 7)) 12:51:24 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 8)) 12:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 12:51:24 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 3)) 12:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.0->mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 12:51:24 INFO - Cleaning up... 12:51:24 INFO - Return code: 0 12:51:24 INFO - Running post-action listener: _resource_record_post_action 12:51:24 INFO - Running post-action listener: _start_resource_monitoring 12:51:24 INFO - Starting resource monitoring. 12:51:24 INFO - ##### 12:51:24 INFO - ##### Running install step. 12:51:24 INFO - ##### 12:51:24 INFO - Running pre-action listener: _resource_record_pre_action 12:51:24 INFO - Running main action method: install 12:51:24 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 12:51:24 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 12:51:24 INFO - Reading from file tmpfile_stdout 12:51:24 INFO - Using _rmtree_windows ... 12:51:24 INFO - Using _rmtree_windows ... 12:51:24 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:24 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 12:51:24 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 12:51:24 INFO - Reading from file tmpfile_stdout 12:51:24 INFO - Output received: 12:51:24 INFO - Usage: mozinstall-script.py [options] installer 12:51:24 INFO - Options: 12:51:24 INFO - -h, --help show this help message and exit 12:51:24 INFO - -d DEST, --destination=DEST 12:51:24 INFO - Directory to install application into. [default: 12:51:24 INFO - "C:\slave\test"] 12:51:24 INFO - --app=APP Application being installed. [default: firefox] 12:51:24 INFO - Using _rmtree_windows ... 12:51:24 INFO - Using _rmtree_windows ... 12:51:24 INFO - mkdir: C:\slave\test\build\application 12:51:24 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-44.0a1.en-US.win32.zip', '--destination', 'C:\\slave\\test\\build\\application'] 12:51:24 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-44.0a1.en-US.win32.zip --destination C:\slave\test\build\application 12:51:26 INFO - Reading from file tmpfile_stdout 12:51:26 INFO - Output received: 12:51:26 INFO - C:\slave\test\build\application\firefox\firefox.exe 12:51:26 INFO - Using _rmtree_windows ... 12:51:26 INFO - Using _rmtree_windows ... 12:51:26 INFO - Running post-action listener: _resource_record_post_action 12:51:26 INFO - ##### 12:51:26 INFO - ##### Running run-tests step. 12:51:26 INFO - ##### 12:51:26 INFO - Running pre-action listener: _resource_record_pre_action 12:51:26 INFO - Running main action method: run_tests 12:51:26 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 12:51:26 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 12:51:26 INFO - Python 2.7.3 12:51:26 INFO - Return code: 0 12:51:26 INFO - grabbing minidump binary from tooltool 12:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:26 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01278B48>, '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 0x0129A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01EAF660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 12:51:26 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 12:51:26 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 12:51:26 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 12:51:29 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpk2ts6k 12:51:29 INFO - INFO - File integrity verified, renaming tmpk2ts6k to win32-minidump_stackwalk.exe 12:51:29 INFO - Return code: 0 12:51:29 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 12:51:29 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 12:51:29 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 12:51:29 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 12:51:29 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 12:51:29 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-003', '--webServer', 'localhost'] in C:\slave\test\build 12:51:29 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-003 --webServer localhost 12:51:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:51:29 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 12:51:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 12:51:29 INFO - 'COMPUTERNAME': 'T-W732-IX-003', 12:51:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:51:29 INFO - 'CYGWINBASE': 'C:\\cygwin', 12:51:29 INFO - 'DCLOCATION': 'SCL3', 12:51:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:51:29 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:51:29 INFO - 'HOMEDRIVE': 'C:', 12:51:29 INFO - 'HOMEPATH': '\\Users\\cltbld', 12:51:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:51:29 INFO - 'KTS_VERSION': '1.19c', 12:51:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 12:51:29 INFO - 'LOGONSERVER': '\\\\T-W732-IX-003', 12:51:29 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 12:51:29 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 12:51:29 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:51:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:29 INFO - 'MOZ_NO_REMOTE': '1', 12:51:29 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 12:51:29 INFO - 'NO_EM_RESTART': '1', 12:51:29 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:51:29 INFO - 'OS': 'Windows_NT', 12:51:29 INFO - 'OURDRIVE': 'C:', 12:51:29 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;', 12:51:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:51:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:51:29 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 12:51:29 INFO - 'PROCESSOR_LEVEL': '6', 12:51:29 INFO - 'PROCESSOR_REVISION': '1e05', 12:51:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:51:29 INFO - 'PROGRAMFILES': 'C:\\Program Files', 12:51:29 INFO - 'PROMPT': '$P$G', 12:51:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:51:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:51:29 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:51:29 INFO - 'PWD': 'C:\\slave\\test', 12:51:29 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 12:51:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:51:29 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:51:29 INFO - 'SYSTEMDRIVE': 'C:', 12:51:29 INFO - 'SYSTEMROOT': 'C:\\windows', 12:51:29 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:51:29 INFO - 'TEST1': 'testie', 12:51:29 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 12:51:29 INFO - 'USERDOMAIN': 'T-W732-IX-003', 12:51:29 INFO - 'USERNAME': 'cltbld', 12:51:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 12:51:29 INFO - 'WINDIR': 'C:\\windows', 12:51:29 INFO - 'WINDOWS_TRACING_FLAGS': '3', 12:51:29 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 12:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:51:29 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-003', '--webServer', 'localhost'] with output_timeout 3600 12:51:30 INFO - mozversion INFO | application_buildid: 20151026104938 12:51:30 INFO - mozversion INFO | application_changeset: b842ef4420f1b247ab9706ce8d5028c8bca52ecd 12:51:30 INFO - mozversion INFO | application_display_name: Nightly 12:51:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:30 INFO - mozversion INFO | application_name: Firefox 12:51:30 INFO - mozversion INFO | application_remotingname: firefox 12:51:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:51:30 INFO - mozversion INFO | application_vendor: Mozilla 12:51:30 INFO - mozversion INFO | application_version: 44.0a1 12:51:30 INFO - mozversion INFO | platform_buildid: 20151026104938 12:51:30 INFO - mozversion INFO | platform_changeset: b842ef4420f1b247ab9706ce8d5028c8bca52ecd 12:51:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:51:30 INFO - mozversion INFO | platform_version: 44.0a1 12:51:30 INFO - 2015-10-26 12:51:30,510 DEBUG : using testdate: 1445889090 12:51:30 INFO - 2015-10-26 12:51:30,510 DEBUG : actual date: 1445889090 12:51:30 INFO - 2015-10-26 12:51:30,719 INFO : starting webserver on 'localhost:49614' 12:51:30 INFO - 2015-10-26 12:51:30,720 INFO : Starting test suite T-W732-IX-003 12:51:30 INFO - 2015-10-26 12:51:30,720 INFO : Starting test dromaeo_css 12:51:30 INFO - 2015-10-26 12:51:30,720 DEBUG : operating with platform_type : w7_ 12:51:30 INFO - 2015-10-26 12:51:30,721 INFO : Initialising browser for dromaeo_css test... 12:51:30 INFO - 2015-10-26 12:51:30,815 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpxmyfav\profile http://localhost:49614/getInfo.html 12:51:39 INFO - 2015-10-26 12:51:39,776 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:51:39 INFO - 2015-10-26 12:51:39,776 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:51:39 INFO - 2015-10-26 12:51:39,776 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 12:51:39 INFO - 2015-10-26 12:51:39,776 DEBUG : BROWSER_OUTPUT: __metrics 12:51:39 INFO - 2015-10-26 12:51:39,951 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:51:40 INFO - 2015-10-26 12:51:40,493 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 12:51:41 INFO - 2015-10-26 12:51:41,506 INFO : Browser initialized. 12:51:41 INFO - 2015-10-26 12:51:41,506 INFO : Running cycle 1/1 for dromaeo_css test... 12:51:41 INFO - 2015-10-26 12:51:41,506 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpxmyfav\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:51:53 INFO - 2015-10-26 12:51:53,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 141524992 12:51:53 INFO - 2015-10-26 12:51:53,161 DEBUG : BROWSER_OUTPUT: 12:52:44 INFO - 2015-10-26 12:52:44,352 DEBUG : BROWSER_OUTPUT: 1445889164323 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] 12:54:57 INFO - 2015-10-26 12:54:57,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49614/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49614/tests/dromaeo/cssquery-ext.html) 12:54:58 INFO - 2015-10-26 12:54:58,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 163598336 12:54:58 INFO - 2015-10-26 12:54:58,407 DEBUG : BROWSER_OUTPUT: 12:58:01 INFO - 2015-10-26 12:58:01,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49614/tests/dromaeo/cssquery-ext.html (next: http://localhost:49614/tests/dromaeo/cssquery-jquery.html) 12:58:01 INFO - 2015-10-26 12:58:01,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 195706880 12:58:01 INFO - 2015-10-26 12:58:01,628 DEBUG : BROWSER_OUTPUT: 13:01:03 INFO - 2015-10-26 13:01:03,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49614/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49614/tests/dromaeo/cssquery-mootools.html) 13:01:04 INFO - 2015-10-26 13:01:04,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 149528576 13:01:04 INFO - 2015-10-26 13:01:04,471 DEBUG : BROWSER_OUTPUT: 13:04:06 INFO - 2015-10-26 13:04:06,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49614/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49614/tests/dromaeo/cssquery-prototype.html) 13:04:07 INFO - 2015-10-26 13:04:07,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 142123008 13:04:07 INFO - 2015-10-26 13:04:07,187 DEBUG : BROWSER_OUTPUT: 13:07:10 INFO - 2015-10-26 13:07:10,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49614/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49614/tests/dromaeo/cssquery-yui.html) 13:07:10 INFO - 2015-10-26 13:07:10,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 139935744 13:07:10 INFO - 2015-10-26 13:07:10,825 DEBUG : BROWSER_OUTPUT: 13:10:13 INFO - 2015-10-26 13:10:13,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49614/tests/dromaeo/cssquery-yui.html (next: http://localhost:49614/tests/dromaeo/cssquery-dojo.html) 13:10:13 INFO - 2015-10-26 13:10:13,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 193929216 13:10:13 INFO - 2015-10-26 13:10:13,937 DEBUG : BROWSER_OUTPUT: 13:10:13 INFO - 2015-10-26 13:10:13,937 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:10:13 INFO - 2015-10-26 13:10:13,937 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:10:13 INFO - 2015-10-26 13:10:13,938 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:10:13 INFO - 2015-10-26 13:10:13,938 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:10:13 INFO - 2015-10-26 13:10:13,938 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2282.463621049053;2349.5653304138723;2368.111958015744;2385.6779334789803;2402.3873912152408;3981.701372397071;4012.4382586437923;4053.27041132596;4055.979720101399;4100.200460910124;4012.358022716366;4103.774292413916;4134.834606615732;4154.771487568182;4180.707350485467;3418.0429479745585;3439.8108104054268;3573.338932297533;3595.586507551626;3635.94546081809;3564.0733409313634;3566.8216589170565;3604.567451905762;3647.7811331320204;3672.4307732301536;3488.982555087221;3634.182308980485;3666;3696.7966761828225;3705.499757532739;3477.8956631301103;3480.617132115465;3496.35317466267;3546.9113272168142;3598.1724203433355;3334.1664583854035;3414.556107706007;3426.2462258303135;3595.0473124621994;3600.459931010343;3803.790791506466;3846.6345697158727;3880.0881792778673;3883.10688541637;3884.4950156479476;4170.979145104255;4361.411209486742;4432.3794668746405;4441.689081764278;4441.955580444219;4071.9592804071876;4139;4158.37624356346;4427.623651989585;4428.092241090569;3802.802117333059;3885.86399476017;3920.764754114762;3924.7056470764805;3930.5479869814767;4029.49631296088;4189.958100419018;4273.829046838154;4287.906583821105;4304.418903448057;4058.918821623551;4063.39049142631;4131.29767939451;4234.55537168599;4286.807093680792;4121.1345617420675;4187.162567486454;4218.924174335525;4392.626626736699;4406.515283318832;4002.2595819773437;4077.959220407758;4170.70805043644;4183.748975061445;4187.581241875788;4051.756894586334;4122.113745544662;4127.112670775798;4166.229247589205;4172.7273181679875;2887.8411687357398;2964.214483161964;2966.925826854346;2979.1211592579807;3022.6826183250882;2615.320016795609;2680.3567143885716;2716.7962402819867;2720.360715231919;2738.9178324650293;3900.9609903901164;3936.803159842054;3939.1530820873077;3942.783146926889;4031.052702614883;4103.309647079788;4183.686223533247;4387.692861499728;4484.506704262529;4487.910241795211;3792.3742582473583;3832.3485007548784;3962.049108214008;3968.7023473239624;4186.246475634354;3704;3707.888763337104;3748.250349930025;3769.4722738816586;3815.790131542736;4301.720388174758;4335.913281734411;4361.585649363432;4571.679982401333;4592.724436533818;4281.78591070439;4373.300271956599;4458.977705111453;4465.6204222640135;4470.262406702987;4111.97200699825;4259.74441533509;4291.849785257501;4437.29003359461;4442.666799989949;4071.491063617048;4089.488813898263;4153.397757325231;4160.500739911109;4179.955011247188;4202.201581699467;4219.261629214937;4315.223259813264;4489.685721999429;4492.955070449384;3965.742226755367;4101.26177288091;4210.242156411875;4298.161858437575;4307.806148723253;4004.15912658345;4019.21625283067;4086.182763447263;4097.528784189737;4100.979495102625;4009;4032.193561287813;4101.343784994387;4174.415581818608;4276.679249056396;4217.093324935154;4288.142371525645;4300.440942677432;4306.310990241672;4319.611234988741;4018.83924643011;4050.6151915567975;4113.074558224375;4174.186033723517;4250.447441832542 13:10:13 INFO - 2015-10-26 13:10:13,940 DEBUG : BROWSER_OUTPUT: |1;ext.html;475.51734988986163;487.04539103357416;506.53904946498693;516.3932379454142;518.1347150259069;25697;34589.82705086471;34673.13317167072;34777.65222347776;36351.81824090879;36020;36576.268474630495;38864.22271554567;38876.22247555047;38961.41557876634;5920.348761636238;6141.232345956755;7937.126916039231;8165.877511837327;8186.754397368089;9592.232621390272;9798.461084640341;9829.262805289596;9834.213262938983;10403.375797452178;10106.343087699275;10228.437435941058;10230.335028223179;10248.333858299224;10259.487025648725;6309.716062777163;6459.321771214049;10070.194384449227;10235.232357573212;10379.532921018572;9317;9337;9338.766530836783;9345.112214339626;9365.063493650581;26351;33613.32773344519;35237.47143792845;36291;36303.63696363029;2124.2671278408925;2460.989479245046;2735.685396179425;2750.064977907501;2751.9862400688066;24624.507509849704;25210;25395.36511587225;25544.616830747553;25668.229953101436;2137.818285445739;2250.077468238031;2257.6952111464907;2260.480089579406;2305;192581;193077;204656;205198;205844;44810.55189448129;45181.41865034774;45229;48136;48315.27527087097;45825.54174458279;47046.76476617595;49975;50011.24983125256;50042;11107.278026928223;11576.305421674726;12108.21296615717;12307;12573.182743121668;8662.913370866338;8732.345074119467;9172.35793494449;9203.861942070875;9216.769580760534;14200.289985500684;14896.201468625432;15728.528144155694;15893.364265429253;15982.520524384287;6566.573172743756;6704;6725.865482690417;7018.789436316919;7101.502894797418;770.3836930455614;777.541250662112;845.691322667222;948.5067764762285;952.5046975572664;25045.121615878517;25259;25365.746342536706;25478;25602.487950241262;829.4401279136558;894.4812009034745;925.546482223719;948.5352177433008;953.8616900549381;12173.573924912585;12215.26708397499;12441.502339906483;12552.372381380894;12659.303738294298;211374;214869;214870;215211;215699;43179;43820.56179438165;44848;44868.3269750954;44926.55073449224;1047.659510659039;1050.6637875879644;1070.8072546941469;1090.7545802194443;1103.7075175078771;24629;24743.937735254978;25127.371815704755;25128;25261.242162735147;37400.438993415664;37543.81228093951;37912;38169.80915095407;38204.359128175034;226189;230729;294885;296744;304638;22784.20255291057;23387.532249354575;23583;23734;24001.51996960086;24885.377865553506;26586.069487567842;35405.468917965736;35472.29055418929;35477;25670.61494077628;28132.156035318974;28795.136145915658;28815.42369152647;30123.3975320488;28314;28853.27866803347;28960.986365477107;29526.261843454085;30291.545626815176;27482.17553473399;27804.304892377044;27874;28494.145175644764;29451;25865.482690346464;27929.581056283765;28894.277643058253;29546.704532954394;29663.85168074146;22017.249640632923;22058.66911996289;22211.88987046228;22502.887485562467;22915.770842291364 13:10:13 INFO - 2015-10-26 13:10:13,947 DEBUG : BROWSER_OUTPUT: |2;jquery.html;284.9558318460639;285.67861156199274;290.14696791433187;290.32644265304486;292.7979694011131;14227.735737777011;14550.490732824353;14605.028321176638;14794.33425495854;15176.696466070673;9061.546922653873;13485.730285394286;13678.726425471485;13701.588952331445;13917.23455209963;3966.2662407454714;4008.599140085997;4176.227397931377;4187.937180942288;4199.7480151190875;3950.328444164499;4167.729097608646;4172.102997855461;4178.6448151907125;4200.655790147154;2722.863856807152;2946.484365236086;3905.628965248297;3956.8327343433757;4432.601065904068;4497.617702495292;4515.300128480075;4524.954750452486;4528.660350473728;4540.931886021713;3645.963540364589;3684.244729830405;3801.106739916145;3803.0492376905772;3817.2747178036084;9160.679376221868;9631.951840240754;9722.659706910295;11004.87317256029;20009;1826.5247910310734;1874.2784028149124;1915.9137838797287;1973.15154483572;1993.6411445939725;12558.434870430852;12696.873031269753;12753;12969.351532423341;14163.433462661482;1713.5630414244288;1764.2325588369101;1884.5948121154017;1941.5728539721238;2052.322733497942;58528.82942341172;62541.68729156325;62875.37124628741;63426.36573634251;64932.67533662301;13562.864371356358;14169.433222670978;14226.502072427415;14258.144511329354;14299.499517516837;18649.347272845385;18915;18942.905285473484;18992.715109273373;19122.139503722366;7553.1313898901235;7584.900189472495;7610.4672672913475;7613.238676132453;7613.9238607614325;6267.373262673696;6274.937250627435;6312.43188113072;6401.391867772554;6491.967540162269;6752.189737231563;6848.212455567674;6867.690953906987;6877.346652068046;6881;2468.3829042739317;2762.267998980272;2809.606655068292;2838.3471801485775;2927.9414411711646;339.33829033384995;348.79072556465917;348.8953314005788;367.9634410516628;376.80217885609727;9378.812423751624;10066.54700538463;10255.179585633132;10441.164706823436;10767.623133190458;369.1951545630551;378.19067196200155;379.42327661953675;383.5416677070929;394.14077311460716;5691.516221121168;5765.106408506688;5805.477507024304;6009.128676341906;6013.759449622054;260041;267291;268555;270160;270412;61737.69131154315;61852.38147618466;62220.06669899955;66989;66992.33007669958;388.34757607219575;396.35987879574856;415.792103948026;423.6145107951749;430.30720539930684;9863.457509837028;9976.60093596277;9994.173219719267;10451.634192803216;10502.159827213653;34766.65233347735;35006.12484687903;35101.297974040885;35381.82309088438;36360.45459318059;45005;45885.541144589464;46214.537854622366;47340.52659473499;48337.51662483471;6553.311902250195;6638.937769956784;6781.966090169518;6837.2820853809635;7122.501424900207;10599;10604.674415698039;10712.303700259457;11254.831177532507;11359.261647992855;9232.630694772133;9283.953580232055;9589.424634521672;9837.458939758095;9848.162906153057;8954.865677014719;9067.773305667411;9239.538023098952;9268.304877134377;9688;9405.764855878384;9463.290253230898;9620.663276785279;9733.415995040321;9737.9026209737;6669.1330127083165;6905.861882762417;6943.68753406108;7048.977898204629;7150.6424678764815;9230.123138301851;9452.43285402878;9622.615095396106;9666.468344241135;9683.564239609375 13:10:13 INFO - 2015-10-26 13:10:13,947 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1081.5781845080426;1189.1972918280162;1261.8611952685203;1387.9306034698266;1466.7873158392033;6494.837629059276;7302.306280903313;7386.298301661333;7420.888686669691;7433.108027036749;7399.926000739991;7482.812929676761;7496.850062998737;7522.661480233389;7923.643436045378;2023.1705000949614;2039.8572099952935;2047.682609195577;2049.4261606750133;2055.1573854719495;2033.247698351612;2053.168466770953;2063.7420322459693;2066.7209926659857;2099.800518950705;1975.7629084509879;2015.29464687359;2061.6186005589016;2071.7203177570987;2071.7410323709537;1972.4279958811928;2025.9189632414686;2029.3404643490776;2034.7151398804178;2034.98982505088;1967.4196112146951;1980.5147738803942;2000.9699854502194;2005.9398218053482;2008.7388639476922;6849.1096157499205;7005.299470053005;7794.805129871742;7816;7820.178881217447;4020.8994775130564;4118.91762164758;4123.175364927027;4144.067584793397;4168.43726096976;2560.539102961466;2596.2730435477906;2599.519088968547;2692.3538350795866;2705.188443466952;783.7217787685404;794.7854079398588;795.1571334385512;802.638812534356;858.2018722587991;11043.779124417466;11175.664730058112;11198.38408887511;11286.492107855167;11301.49143288554;3919.8040097994985;3927.8821635350987;4011.2178125265877;4092.3656833190903;4187.874363769091;8904.955475222583;9006.414583052212;9025.277977761763;9027.322950778718;9045.32160087996;4313.633341165973;4318.3090705486975;4328.978355108205;4332.761698106571;4355.62977146946;3869.2068126034096;3869.787161706077;3878.8557375574273;3882.941755873664;3905.1994341159993;3145.4495463293833;3351.614564325134;3371.713404360608;3374.342003309331;3375.3080618473646;1054.7890421915495;1057.318029870729;1066.2003497376968;1077.7467295185625;1080.735219871121;852.3394369363668;871.289898732531;873.2969959182792;873.5588527793424;874.6894852327332;6935.965320173367;7062;7133.215346311901;7522.98439710643;7528.473006889575;404.6499777692275;404.7045656670647;409.90572168401434;410.43974974160056;419.83416550462397;5475.315585551806;5696.829095127153;5764.308283006066;5782.681952492653;5788.218590490314;9048.638054477879;9151.176394124428;9283.210927071139;9692.563834627459;9741.756456088655;9377;9618.326717129874;9633.421994680202;9638;9661.855072173923;7135.179454362711;7150.821229469201;7214.278572142849;7223.386012189023;7248.96375518119;6981.79054628362;7048.330408611174;7379.520331178456;7381.04046473955;7385.446091543263;7954.244346787046;8093.959530202547;8139.023317201973;8416.747497575083;8419.36854735885;8817.911820881965;8836;8842.071582483746;8844.911550884408;8846.955765221133;7036.577805331696;7107.0760801097595;7114.075170227838;7115.6086415247655;7117.252688467636;7730.884036739566;7879.172686867796;7885.526868387915;7892.526448413114;7892.526448413114;6656.500762442933;6951.895721564079;6961.955706644044;7366.631668416665;7412.518186317872;6591.439727623206;6799;7022.859542809218;7050.118735158106;7201.927980720126;6783.186017677713;6826;7037.296270373126;7205.171405288249;7241.13106427211;6041.969790151021;6043.7884674036195;6048.183495228088;6064.151018857452;6066.696665166813;6204.72078756448;6206.224221972254;6480.805575832733;6584.078229047841;6614.239362473185 13:10:13 INFO - 2015-10-26 13:10:13,948 DEBUG : BROWSER_OUTPUT: |4;prototype.html;274.11597597747254;276.3574688848427;277.31918140963927;277.70563203004804;281.38236570727247;4251.107267473834;4321.243782338086;4380.649548036154;4429.114177164568;4595.816167353306;4241.448611680485;4544.454665440144;4552.226121559334;4556.772161391934;4566.04113136241;3471.218975730466;3497.335506253816;3499.842507087187;3501.684848363647;3503.194265318978;3337.5828021497314;3387.2548039431285;3446.190145315849;3504.8598056077726;3511.2801875615437;3276.950845737316;3376.7973921564662;3420.572428446444;3465.6361082086396;3472.3923313420178;3258.885938992136;3260.951085733716;3262.869485220588;3363.1592101974506;3451.188970591934;2904.375559254749;2910.4761142994253;2915.9708402915912;2920.926976825575;2925.7805664575244;4179.205950869356;4180;4182.811773470201;4196.853110141131;4238.173556156551;3902.551206611219;3970.007498125469;3990.1221731219084;4126.5667104953845;4136.544980052192;4581.4502259728715;4586.876215327233;4597.126545956291;4601.815927362902;4750.311204875308;3317.5853018372704;3322.534845121685;3322.60128784545;3323.285493618859;3534.6288639692975;4674.672772905898;4720.716756994591;4743.288506723985;4763.64272679547;5030.798768049273;3358.8152651604396;3403.0301364111606;3456.2569047654874;3468.21965057865;3528.2590655962535;3495.9825200873834;3552.786832789989;3636.7636103653176;3669.412893936957;3676.558812942464;4145.253854306254;4146.274401979702;4151.626353628188;4151.771652559078;4153.397757325171;4550.203714349976;4551.704139230939;4763.428388593391;4832.758362081881;4835.419749629997;1224.161449407159;1231.593574120538;1231.852177738677;1235.5243231355992;1235.932023738685;892.7187935800332;901.4906577783531;925.0102390442297;927.1933417926447;931.1526510875071;4417.491988421372;4427.2252355838245;4495.056038232008;4663.183942809995;4670.673052886265;4749.715017098985;4752.572268495852;4763.118823017753;4770.499097594772;4781;4384.167008268419;4655.580997710154;4664.300354946785;4667.439907211156;4672.275797251432;2585.9482810344066;2586.7801236894697;2627.7766389856693;2711.064682684471;2752.6696796384563;4850.684705494132;4863.659543831968;5116.386033675983;5162.845114646567;5165.638405311592;4758.405199350082;5142.202958541432;5149.021685879671;5150.97424512875;5159.58723302135;5162.5869930406225;5167.896642067138;5175.327207463081;5177.119889618773;5185.948140518546;4734.881627959191;4749.382580264543;4754.928676069792;4923.704577725348;5040.747962601782;4636.165490211794;4646.488886222581;4648.628109751279;4649.767511624337;4705.20011598036;4882.951170488392;4909.968906529669;5159.458256882973;5163.406208285945;5164.483551644806;3369.3935091683734;3601.9639803602677;3603.261331426999;3611.3138503684218;3612.385894397906;4587.128445595326;4649.372334734768;4860.3195552621955;4900.26496025599;5006.349174607278;4555;4560.361549383023;4564.452265728134;4565.703229290086;4598.885027874196;4551.5676010778925;4659.114768194032;4828.058528587032;4833.3958255218095;4833.564979151894;4449.976505403711;4491.595756381941;4714.15145273854;4728.71627702339;4731.195696731633;4567.383403240653;4715.174844402147;4895.461499235153;4940.802367905244;4945.653804233669;4744.383230180055;4818.4217893852965;4843.491433399442;4860.586850117779;4870 13:10:13 INFO - 2015-10-26 13:10:13,950 DEBUG : BROWSER_OUTPUT: |5;yui.html;672.4788289075968;676.8071099736576;688.4988055139258;689.5138927056429;735.8454724507853;10264.640737574186;10284.485775711213;10326;10352.53413596388;10750.193735469831;10520.421376824272;10639.680809575706;10686.091682207021;10699.304545204557;10718.088962438183;458.7935429056921;466.24701107711144;613.923259592551;615.0743131586955;623.5167744997641;616.8735409241095;617.7065893700478;619.66847736461;621.9626822390671;622.5393209025334;618.1623899616023;644.7227692092398;650.3593959949446;650.9609423434609;655.3708439897704;472.503870935518;473.7725891572047;611.300061429665;628.1896353703717;628.9433950944436;448.0367210497424;476.7640018190983;476.8307250925906;477.57495828712473;477.62506432450357;9827.164691001273;9873.864505581807;9882.65410710629;10202.132818710419;10472.581096756121;9923.1069203772;9944.70165895017;10005.849327327378;10081.596736130547;10647.84028239577;8466.915330846674;8820.911790882074;8879.422837515542;8985.46087234768;9103.681371151977;3135.886760200142;3151.7636177286568;3182.6817318268218;3184.251700850298;3189.5534625152495;32263.193420164447;32296.54665540033;32333.473313736096;33568.6643133568;34463.483047754555;7740.612969351622;8041.678332866737;8088.757337279891;8105.31104856082;8111.797205069921;13851.16892986424;14505.854941450661;14684.85315146835;14689.92655036718;14717.632059198606;5458.2904222450825;5797.826065218051;6009.429104235091;6079.908801367983;6176.69116544171;3371.325734853039;3409.369266685671;3418.7948723076197;3419.5725534308212;3428.502867084259;2333.9299821005397;2348.2368230325214;2393.1863166523467;2425.0905910283645;2459.864707441108;361.24860290596024;373.22183247928376;373.51816157156964;378.2661636425326;383.11500433997554;470.94978198617275;564.6386312759837;606.3784620763664;611.7614130489113;625.7622103600603;7499.887501687479;7649.349805266615;7777.650005749755;8106.310963568163;8285.95857020723;424.5605797999056;449.910017996402;485.7231378114511;551.3218740948655;560.330405165823;3447.8620855165514;3468.8265586720563;3515.2793677296604;3546.8403921823065;3547.9710883843395;38586.614133858864;38753.612463875565;38976.22047559033;38987.6101238984;39053;32549.674503255137;32740.017799466055;33035.834820825745;34703.4794478078;35651.4652280216;30716.692833072277;31021.68978310188;32226.194345141557;32365.19087022796;32612.18469538233;6854.725810967506;7455.776326710207;7475;7535.886961695689;7610.9238907610215;22342.66486002744;22383.44041398978;22498;22599.435014124778;22640;30328.84835575808;30331.18012919232;30365.848170759004;32300.515492267165;32374.35251295008;6080.300765412034;6100.572959892942;6273.090401891609;6572.967135164294;6843.965780171067;10566.524506397383;10658.216333201912;10778.407187604756;10931.18016148776;10976.286541374786;9888.505574721092;9897.752556186153;10016.499175041074;10019.697439333131;10242.75161726348;9739.123478886933;9939.105480506789;10319.277650564389;10338.793224135625;10414.947925260629;9166;9272.72181834546;9549.236061114954;9916.958719334367;10010.399376037461;8628.870566941376;8780.824383512421;8856.601452934505;8859.689910853347;8972.775680608038;8060.787244643747;8446.66213351459;8511.702090426805;8563.61463734121;8587.484750914966 13:10:13 INFO - 2015-10-26 13:10:13,951 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:10:13 INFO - 2015-10-26 13:10:13,951 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:10:13 INFO - 2015-10-26 13:10:13,951 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,866 13:10:13 INFO - 2015-10-26 13:10:13,951 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:10:13 INFO - 2015-10-26 13:10:13,951 DEBUG : BROWSER_OUTPUT: __startTimestamp1445890213912__endTimestamp 13:10:13 INFO - 2015-10-26 13:10:13,951 DEBUG : BROWSER_OUTPUT: 13:10:13 INFO - 2015-10-26 13:10:13,967 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:10:13 INFO - 2015-10-26 13:10:13,967 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:10:13 INFO - 2015-10-26 13:10:13,967 DEBUG : BROWSER_OUTPUT: 13:10:13 INFO - 2015-10-26 13:10:13,967 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:3926.52 Median:4071.96 stddev:490.23 (12.0%) stddev-sans-first:474.47 13:10:13 INFO - 2015-10-26 13:10:13,967 DEBUG : BROWSER_OUTPUT: Values: 2282.5 2349.6 2368.1 2385.7 2402.4 3981.7 4012.4 4053.3 4056.0 4100.2 4012.4 4103.8 4134.8 4154.8 4180.7 3418.0 3439.8 3573.3 3595.6 3635.9 3564.1 3566.8 3604.6 3647.8 3672.4 3489.0 3634.2 3666.0 3696.8 3705.5 3477.9 3480.6 3496.4 3546.9 3598.2 3334.2 3414.6 3426.2 3595.0 3600.5 3803.8 3846.6 3880.1 3883.1 3884.5 4171.0 4361.4 4432.4 4441.7 4442.0 4072.0 4139.0 4158.4 4427.6 4428.1 3802.8 3885.9 3920.8 3924.7 3930.5 4029.5 4190.0 4273.8 4287.9 4304.4 4058.9 4063.4 4131.3 4234.6 4286.8 4121.1 4187.2 4218.9 4392.6 4406.5 4002.3 4078.0 4170.7 4183.7 4187.6 4051.8 4122.1 4127.1 4166.2 4172.7 2887.8 2964.2 2966.9 2979.1 3022.7 2615.3 2680.4 2716.8 2720.4 2738.9 3901.0 3936.8 3939.2 3942.8 4031.1 4103.3 4183.7 4387.7 4484.5 4487.9 3792.4 3832.3 3962.0 3968.7 4186.2 3704.0 3707.9 3748.3 3769.5 3815.8 4301.7 4335.9 4361.6 4571.7 4592.7 4281.8 4373.3 4459.0 4465.6 4470.3 4112.0 4259.7 4291.8 4437.3 4442.7 4071.5 4089.5 4153.4 4160.5 4180.0 4202.2 4219.3 4315.2 4489.7 4493.0 3965.7 4101.3 4210.2 4298.2 4307.8 4004.2 4019.2 4086.2 4097.5 4101.0 4009.0 4032.2 4101.3 4174.4 4276.7 4217.1 4288.1 4300.4 4306.3 4319.6 4018.8 4050.6 4113.1 4174.2 4250.4 13:10:13 INFO - 2015-10-26 13:10:13,967 DEBUG : BROWSER_OUTPUT: 13:10:13 INFO - 2015-10-26 13:10:13,967 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37311.63 Median:28834.35 stddev:60348.41 (209.3%) stddev-sans-first:60454.32 13:10:13 INFO - 2015-10-26 13:10:13,967 DEBUG : BROWSER_OUTPUT: Values: 475.5 487.0 506.5 516.4 518.1 25697.0 34589.8 34673.1 34777.7 36351.8 36020.0 36576.3 38864.2 38876.2 38961.4 5920.3 6141.2 7937.1 8165.9 8186.8 9592.2 9798.5 9829.3 9834.2 10403.4 10106.3 10228.4 10230.3 10248.3 10259.5 6309.7 6459.3 10070.2 10235.2 10379.5 9317.0 9337.0 9338.8 9345.1 9365.1 26351.0 33613.3 35237.5 36291.0 36303.6 2124.3 2461.0 2735.7 2750.1 2752.0 24624.5 25210.0 25395.4 25544.6 25668.2 2137.8 2250.1 2257.7 2260.5 2305.0 192581.0 193077.0 204656.0 205198.0 205844.0 44810.6 45181.4 45229.0 48136.0 48315.3 45825.5 47046.8 49975.0 50011.2 50042.0 11107.3 11576.3 12108.2 12307.0 12573.2 8662.9 8732.3 9172.4 9203.9 9216.8 14200.3 14896.2 15728.5 15893.4 15982.5 6566.6 6704.0 6725.9 7018.8 7101.5 770.4 777.5 845.7 948.5 952.5 25045.1 25259.0 25365.7 25478.0 25602.5 829.4 894.5 925.5 948.5 953.9 12173.6 12215.3 12441.5 12552.4 12659.3 211374.0 214869.0 214870.0 215211.0 215699.0 43179.0 43820.6 44848.0 44868.3 44926.6 1047.7 1050.7 1070.8 1090.8 1103.7 24629.0 24743.9 25127.4 25128.0 25261.2 37400.4 37543.8 37912.0 38169.8 38204.4 226189.0 230729.0 294885.0 296744.0 304638.0 22784.2 23387.5 23583.0 23734.0 24001.5 24885.4 26586.1 35405.5 35472.3 35477.0 25670.6 28132.2 28795.1 28815.4 30123.4 28314.0 28853.3 28961.0 29526.3 30291.5 27482.2 27804.3 27874.0 28494.1 29451.0 25865.5 27929.6 28894.3 29546.7 29663.9 22017.2 22058.7 22211.9 22502.9 22915.8 13:10:13 INFO - 2015-10-26 13:10:13,967 DEBUG : BROWSER_OUTPUT: 13:10:13 INFO - 2015-10-26 13:10:13,967 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:19406.48 Median:2212.20 stddev:44735.50 (2022.2%) stddev-sans-first:44837.96 13:10:13 INFO - 2015-10-26 13:10:13,967 DEBUG : BROWSER_OUTPUT: Values: 285.0 285.7 290.1 290.3 292.8 14227.7 14550.5 14605.0 14794.3 15176.7 9061.5 13485.7 13678.7 13701.6 13917.2 3966.3 4008.6 4176.2 4187.9 4199.7 3950.3 4167.7 4172.1 4178.6 4200.7 2722.9 2946.5 3905.6 3956.8 4432.6 4497.6 4515.3 4525.0 4528.7 4540.9 3646.0 3684.2 3801.1 3803.0 3817.3 9160.7 9632.0 9722.7 11004.9 20009.0 1826.5 1874.3 1915.9 1973.2 1993.6 12558.4 12696.9 12753.0 12969.4 14163.4 1713.6 1764.2 1884.6 1941.6 2052.3 58528.8 62541.7 62875.4 63426.4 64932.7 13562.9 14169.4 14226.5 14258.1 14299.5 18649.3 18915.0 18942.9 18992.7 19122.1 7553.1 7584.9 7610.5 7613.2 7613.9 6267.4 6274.9 6312.4 6401.4 6492.0 6752.2 6848.2 6867.7 6877.3 6881.0 2468.4 2762.3 2809.6 2838.3 2927.9 339.3 348.8 348.9 368.0 376.8 9378.8 10066.5 10255.2 10441.2 10767.6 369.2 378.2 379.4 383.5 394.1 5691.5 5765.1 5805.5 6009.1 6013.8 260041.0 267291.0 268555.0 270160.0 270412.0 61737.7 61852.4 62220.1 66989.0 66992.3 388.3 396.4 415.8 423.6 430.3 9863.5 9976.6 9994.2 10451.6 10502.2 34766.7 35006.1 35101.3 35381.8 36360.5 45005.0 45885.5 46214.5 47340.5 48337.5 6553.3 6638.9 6782.0 6837.3 7122.5 10599.0 10604.7 10712.3 11254.8 11359.3 9232.6 9284.0 9589.4 9837.5 9848.2 8954.9 9067.8 9239.5 9268.3 9688.0 9405.8 9463.3 9620.7 9733.4 9737.9 6669.1 6905.9 6943.7 7049.0 7150.6 9230.1 9452.4 9622.6 9666.5 9683.6 13:10:13 INFO - 2015-10-26 13:10:13,974 DEBUG : BROWSER_OUTPUT: 13:10:13 INFO - 2015-10-26 13:10:13,974 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5309.88 Median:6602.84 stddev:2983.28 (45.2%) stddev-sans-first:2974.72 13:10:13 INFO - 2015-10-26 13:10:13,974 DEBUG : BROWSER_OUTPUT: Values: 1081.6 1189.2 1261.9 1387.9 1466.8 6494.8 7302.3 7386.3 7420.9 7433.1 7399.9 7482.8 7496.9 7522.7 7923.6 2023.2 2039.9 2047.7 2049.4 2055.2 2033.2 2053.2 2063.7 2066.7 2099.8 1975.8 2015.3 2061.6 2071.7 2071.7 1972.4 2025.9 2029.3 2034.7 2035.0 1967.4 1980.5 2001.0 2005.9 2008.7 6849.1 7005.3 7794.8 7816.0 7820.2 4020.9 4118.9 4123.2 4144.1 4168.4 2560.5 2596.3 2599.5 2692.4 2705.2 783.7 794.8 795.2 802.6 858.2 11043.8 11175.7 11198.4 11286.5 11301.5 3919.8 3927.9 4011.2 4092.4 4187.9 8905.0 9006.4 9025.3 9027.3 9045.3 4313.6 4318.3 4329.0 4332.8 4355.6 3869.2 3869.8 3878.9 3882.9 3905.2 3145.4 3351.6 3371.7 3374.3 3375.3 1054.8 1057.3 1066.2 1077.7 1080.7 852.3 871.3 873.3 873.6 874.7 6936.0 7062.0 7133.2 7523.0 7528.5 404.6 404.7 409.9 410.4 419.8 5475.3 5696.8 5764.3 5782.7 5788.2 9048.6 9151.2 9283.2 9692.6 9741.8 9377.0 9618.3 9633.4 9638.0 9661.9 7135.2 7150.8 7214.3 7223.4 7249.0 6981.8 7048.3 7379.5 7381.0 7385.4 7954.2 8094.0 8139.0 8416.7 8419.4 8817.9 8836.0 8842.1 8844.9 8847.0 7036.6 7107.1 7114.1 7115.6 7117.3 7730.9 7879.2 7885.5 7892.5 7892.5 6656.5 6951.9 6962.0 7366.6 7412.5 6591.4 6799.0 7022.9 7050.1 7201.9 6783.2 6826.0 7037.3 7205.2 7241.1 6042.0 6043.8 6048.2 6064.2 6066.7 6204.7 6206.2 6480.8 6584.1 6614.2 13:10:13 INFO - 2015-10-26 13:10:13,976 DEBUG : BROWSER_OUTPUT: 13:10:13 INFO - 2015-10-26 13:10:13,976 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:3975.21 Median:4553.61 stddev:1170.64 (25.7%) stddev-sans-first:1140.49 13:10:13 INFO - 2015-10-26 13:10:13,976 DEBUG : BROWSER_OUTPUT: Values: 274.1 276.4 277.3 277.7 281.4 4251.1 4321.2 4380.6 4429.1 4595.8 4241.4 4544.5 4552.2 4556.8 4566.0 3471.2 3497.3 3499.8 3501.7 3503.2 3337.6 3387.3 3446.2 3504.9 3511.3 3277.0 3376.8 3420.6 3465.6 3472.4 3258.9 3261.0 3262.9 3363.2 3451.2 2904.4 2910.5 2916.0 2920.9 2925.8 4179.2 4180.0 4182.8 4196.9 4238.2 3902.6 3970.0 3990.1 4126.6 4136.5 4581.5 4586.9 4597.1 4601.8 4750.3 3317.6 3322.5 3322.6 3323.3 3534.6 4674.7 4720.7 4743.3 4763.6 5030.8 3358.8 3403.0 3456.3 3468.2 3528.3 3496.0 3552.8 3636.8 3669.4 3676.6 4145.3 4146.3 4151.6 4151.8 4153.4 4550.2 4551.7 4763.4 4832.8 4835.4 1224.2 1231.6 1231.9 1235.5 1235.9 892.7 901.5 925.0 927.2 931.2 4417.5 4427.2 4495.1 4663.2 4670.7 4749.7 4752.6 4763.1 4770.5 4781.0 4384.2 4655.6 4664.3 4667.4 4672.3 2585.9 2586.8 2627.8 2711.1 2752.7 4850.7 4863.7 5116.4 5162.8 5165.6 4758.4 5142.2 5149.0 5151.0 5159.6 5162.6 5167.9 5175.3 5177.1 5185.9 4734.9 4749.4 4754.9 4923.7 5040.7 4636.2 4646.5 4648.6 4649.8 4705.2 4883.0 4910.0 5159.5 5163.4 5164.5 3369.4 3602.0 3603.3 3611.3 3612.4 4587.1 4649.4 4860.3 4900.3 5006.3 4555.0 4560.4 4564.5 4565.7 4598.9 4551.6 4659.1 4828.1 4833.4 4833.6 4450.0 4491.6 4714.2 4728.7 4731.2 4567.4 4715.2 4895.5 4940.8 4945.7 4744.4 4818.4 4843.5 4860.6 4870.0 13:10:13 INFO - 2015-10-26 13:10:13,976 DEBUG : BROWSER_OUTPUT: 13:10:13 INFO - 2015-10-26 13:10:13,976 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10176.96 Median:462.52 stddev:10664.85 (2305.8%) stddev-sans-first:10670.88 13:10:13 INFO - 2015-10-26 13:10:13,976 DEBUG : BROWSER_OUTPUT: Values: 672.5 676.8 688.5 689.5 735.8 10264.6 10284.5 10326.0 10352.5 10750.2 10520.4 10639.7 10686.1 10699.3 10718.1 458.8 466.2 613.9 615.1 623.5 616.9 617.7 619.7 622.0 622.5 618.2 644.7 650.4 651.0 655.4 472.5 473.8 611.3 628.2 628.9 448.0 476.8 476.8 477.6 477.6 9827.2 9873.9 9882.7 10202.1 10472.6 9923.1 9944.7 10005.8 10081.6 10647.8 8466.9 8820.9 8879.4 8985.5 9103.7 3135.9 3151.8 3182.7 3184.3 3189.6 32263.2 32296.5 32333.5 33568.7 34463.5 7740.6 8041.7 8088.8 8105.3 8111.8 13851.2 14505.9 14684.9 14689.9 14717.6 5458.3 5797.8 6009.4 6079.9 6176.7 3371.3 3409.4 3418.8 3419.6 3428.5 2333.9 2348.2 2393.2 2425.1 2459.9 361.2 373.2 373.5 378.3 383.1 470.9 564.6 606.4 611.8 625.8 7499.9 7649.3 7777.7 8106.3 8286.0 424.6 449.9 485.7 551.3 560.3 3447.9 3468.8 3515.3 3546.8 3548.0 38586.6 38753.6 38976.2 38987.6 39053.0 32549.7 32740.0 33035.8 34703.5 35651.5 30716.7 31021.7 32226.2 32365.2 32612.2 6854.7 7455.8 7475.0 7535.9 7610.9 22342.7 22383.4 22498.0 22599.4 22640.0 30328.8 30331.2 30365.8 32300.5 32374.4 6080.3 6100.6 6273.1 6573.0 6844.0 10566.5 10658.2 10778.4 10931.2 10976.3 9888.5 9897.8 10016.5 10019.7 10242.8 9739.1 9939.1 10319.3 10338.8 10414.9 9166.0 9272.7 9549.2 9917.0 10010.4 8628.9 8780.8 8856.6 8859.7 8972.8 8060.8 8446.7 8511.7 8563.6 8587.5 13:10:13 INFO - 2015-10-26 13:10:13,979 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:10:13 INFO - 2015-10-26 13:10:13,979 DEBUG : BROWSER_OUTPUT: 13:10:14 INFO - 2015-10-26 13:10:14,529 INFO : Browser exited with error code: 0 13:10:15 INFO - 2015-10-26 13:10:15,266 INFO : Completed test dromaeo_css (00:18:44) 13:10:15 INFO - 2015-10-26 13:10:15,266 INFO : Starting test kraken 13:10:15 INFO - 2015-10-26 13:10:15,266 DEBUG : operating with platform_type : w7_ 13:10:15 INFO - 2015-10-26 13:10:15,266 INFO : Initialising browser for kraken test... 13:10:15 INFO - 2015-10-26 13:10:15,292 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpn3kfl1\profile http://localhost:49614/getInfo.html 13:10:19 INFO - 2015-10-26 13:10:19,855 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:10:19 INFO - 2015-10-26 13:10:19,855 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:10:19 INFO - 2015-10-26 13:10:19,855 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 13:10:19 INFO - 2015-10-26 13:10:19,855 DEBUG : BROWSER_OUTPUT: __metrics 13:10:19 INFO - 2015-10-26 13:10:19,943 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:10:21 INFO - 2015-10-26 13:10:21,046 DEBUG : BROWSER_OUTPUT: console.error: 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no] 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: Stack: 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 13:10:21 INFO - 2015-10-26 13:10:21,049 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promisedromaeo_css: 5590.15 13:12:00 INFO - RETURN: kraken: 1633.50 13:12:00 INFO - RETURN: v8_7: 19960.55 13:12:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,25]]", "result": "19960.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,25]]", "result": "1633.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,25]]", "result": "5590.15"}}} 13:12:00 INFO - Return code: 0 13:12:00 INFO - # TBPL SUCCESS # 13:12:00 INFO - Running post-action listener: _resource_record_post_action 13:12:00 INFO - Running post-run listener: _resource_record_post_run 13:12:01 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 180388352; Write bytes: 423741952; Read time: 2438550; Write time: 4736960 13:12:01 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 1579008; Read time: 0; Write time: 7780 13:12:01 INFO - run-tests - Wall time: 1235s; CPU: 13.0%; Read bytes: 180388352; Write bytes: 401019392; Read time: 2438550; Write time: 4708330 13:12:01 INFO - Running post-run listener: _upload_blobber_files 13:12:01 INFO - Blob upload gear active. 13:12:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:12:01 INFO - Copying logs to upload dir... 13:12:01 INFO - mkdir: C:\slave\test\build\upload\logs program finished with exit code 0 elapsedTime=1457.319000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 33 secs) (at 2015-10-26 13:12:19.071939) ========= ========= Started set props: build_url (results: 0, elapsed: 8 secs) (at 2015-10-26 13:12:19.080310) ========= '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-003 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-003 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-003 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 build_url:https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/-6eQ_0maRgqxblqfdARwDw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip' ========= Finished set props: build_url (results: 0, elapsed: 8 secs) (at 2015-10-26 13:12:27.911787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2015-10-26 13:12:27.912101) ========= '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-003 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-003 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-003 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 ========= Finished 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2015-10-26 13:12:38.270122) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-26 13:12:38.270419) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-26 13:12:39.130482) =========