2-Mar-85 16:36:20 **** Log file for SEQUENTIAL runs of SANNELLA Machine: Forrestal (Dorado) Microcode Version: [24, 4] Lisp System Date: 2-Mar-85 16:31:32 Memory Size: 10000Q Sysout's true MAKESYSDATE = 20-Dec-84 12:16:57 ->->->->->Freshly Loaded<-<-<-<- ******************************************************************* TAK variations -- TAK, CTAK, TAKR, and TAKL Tests fixed-point arithmetic and function-to-function interface CTAK uses CATCH-like control rather than recursion TAKL uses lists instead of integers for 'arithmtic' ******************************************************************* ={PHYLUM}TAK.DCOM;2 {PHYLUM}TAK.DCOM;2 compiled on 14-FEB-83 10:11:48 FILE CREATED 14-FEB-83 10:11:44 TAKCOMS Commenceing on TAK run: (TIMEALL (TAK 18 12 6)) Elapsed Time = .553 seconds SWAP time = .024 seconds CPU Time = .529 seconds PAGEFAULTS = 1 DISKOPS = 1 Value = 7 Repeating the TIMEALL Elapsed Time = .554 seconds CPU Time = .554 seconds Value = 7 TAK finished ={PHYLUM}TAKR.DCOM;2 {PHYLUM}TAKR.DCOM;2 compiled on 14-FEB-83 10:52:58 FILE CREATED 14-FEB-83 10:52:35 TAKRCOMS Commenceing on TAKR run: (TIMEALL (TAK0 18 12 6)) Elapsed Time = .697 seconds CPU Time = .697 seconds Value = 7 Repeating the TIMEALL Elapsed Time = .696 seconds CPU Time = .696 seconds Value = 7 TAKR finished ={PHYLUM}TAKL.DCOM;1 {PHYLUM}TAKL.DCOM;1 compiled on 14-FEB-83 11:45:23 FILE CREATED 14-FEB-83 11:45:11 TAKLCOMS Commenceing on TAKL run: (TIMEALL (TAKL 18L 12L 6L)) Elapsed Time = 3.93 seconds CPU Time = 3.93 seconds Value = (7 6 5 4 3 2 1) Repeating the TIMEALL Elapsed Time = 3.93 seconds CPU Time = 3.93 seconds Value = (7 6 5 4 3 2 1) TAKL finished ->->->->->Freshly Loaded<-<-<-<- ={PHYLUM}CTAK.DCOM;1 {PHYLUM}CTAK.DCOM;1 compiled on 5-JUL-83 13:07:11 FILE CREATED 5-JUL-83 13:07:00 CTAKCOMS Commenceing on CTAK run: (TIMEALL (TAK 18 12 6)) Elapsed Time = 24.9 seconds SWAP time = .023 seconds CPU Time = 24.9 seconds PAGEFAULTS = 1 DISKOPS = 1 Value = 7 Repeating the TIMEALL Elapsed Time = 24.9 seconds CPU Time = 24.9 seconds Value = 7 CTAK finished ->->->->->Freshly Loaded<-<-<-<- ******************************************************************* CONSy BenchMarks -- BOYER, BROWSE, DERIV (and DDERIV), DIV2 BOYER is from a rule-rewrite section of a theorem prover; BROWSE is a plist-based list pattern matcher; DERIV is symbolic differentiation; DDERIV is same, but plist-based; DIV2 'divides' a long list in half by consing up every other element (once iterative, once recursive). ******************************************************************* ={PHYLUM}BOYER.DCOM;1 {PHYLUM}BOYER.DCOM;1 compiled on 5-JUL-83 21:34:56 FILE CREATED 5-JUL-83 21:34:28 BOYERCOMS Initializing BOYER run: (TIMEALL (SETUP)) Elapsed Time = .991 seconds SWAP time = .972 seconds CPU Time = .019 seconds PAGEFAULTS = 38 DISKOPS = 36 LISTP 224 Commenceing on BOYER run: (TIMEALL (TEST)) Elapsed Time = 35.5 seconds GC time = 13.2 seconds CPU Time = 22.3 seconds PAGEFAULTS = 558 DISKOPS = 2 FIXP LISTP 3 226469 Repeating the TIMEALL Elapsed Time = 34.4 seconds SWAP time = .03 seconds GC time = 13.6 seconds CPU Time = 20.8 seconds PAGEFAULTS = 1 DISKOPS = 1 FIXP LISTP 4 226469 BOYER finished ->->->->->Freshly Loaded<-<-<-<- ={PHYLUM}BROWSE.DCOM;11 {PHYLUM}BROWSE.DCOM;11 compiled on 28-Nov-84 19:19:05 FILE CREATED 28-Nov-84 19:18:36 BROWSECOMS Commenceing on BROWSE run: (TIMEALL (BROWSE)) Elapsed Time = 110.0 seconds SWAP time = 10.2 seconds GC time = 42.8 seconds CPU Time = 57.4 seconds PAGEFAULTS = 437 DISKOPS = 340 LISTP 488945 Value = NIL Repeating the TIMEALL Elapsed Time = 104.0 seconds SWAP time = .105 seconds GC time = 43.9 seconds CPU Time = 59.6 seconds PAGEFAULTS = 75 DISKOPS = 5 LISTP 488945 Value = NIL Repeating the TIMEALL Elapsed Time = 105.0 seconds SWAP time = .035 seconds GC time = 44.3 seconds CPU Time = 60.4 seconds PAGEFAULTS = 70 DISKOPS = 1 LISTP 488945 Value = NIL BROWSE finished ->->->->->Freshly Loaded<-<-<-<- ={PHYLUM}DERIV.DCOM;2 {PHYLUM}DERIV.DCOM;2 compiled on 10-FEB-83 13:56:57 FILE CREATED 10-FEB-83 13:56:46 DERIVCOMS Commenceing on DERIV run: (TIMEALL (RUN)) Elapsed Time = 26.0 seconds SWAP time = .198 seconds GC time = 17.8 seconds CPU Time = 7.97 seconds PAGEFAULTS = 50 DISKOPS = 12 LISTP 245000 Value = NIL Repeating the TIMEALL Elapsed Time = 25.6 seconds GC time = 17.7 seconds CPU Time = 7.89 seconds LISTP 245000 Value = NIL DERIV finished ={PHYLUM}DDERIV.DCOM;2 {PHYLUM}DDERIV.DCOM;2 compiled on 11-FEB-83 14:22:00 FILE CREATED 11-FEB-83 14:21:49 (RUN redefined) (DERIV redefined) (DER1 redefined) DDERIVCOMS Commenceing on DDERIV run: (TIMEALL (RUN)) Elapsed Time = 29.5 seconds GC time = 19.4 seconds CPU Time = 10.1 seconds PAGEFAULTS = 8 LISTP 260000 Value = NIL Repeating the TIMEALL Elapsed Time = 29.1 seconds GC time = 19.2 seconds CPU Time = 9.97 seconds LISTP 260000 Value = NIL DDERIV finished ={PHYLUM}DIV2.DCOM;3 {PHYLUM}DIV2.DCOM;3 compiled on 10-FEB-83 13:34:10 FILE CREATED 10-FEB-83 13:34:00 DIV2COMS Commenceing on DIV2 run: (TIMEALL (TEST1 L)) Elapsed Time = 11.2 seconds GC time = 8.45 seconds CPU Time = 2.79 seconds LISTP 120000 Repeating the TIMEALL Elapsed Time = 11.1 seconds GC time = 8.32 seconds CPU Time = 2.82 seconds LISTP 120000 Commenceing on DIV2 run: (TIMEALL (TEST2 L)) Elapsed Time = 12.4 seconds GC time = 8.28 seconds CPU Time = 4.1 seconds LISTP 120000 Repeating the TIMEALL Elapsed Time = 12.2 seconds GC time = 8.07 seconds CPU Time = 4.11 seconds LISTP 120000 DIV2 finished ->->->->->Freshly Loaded<-<-<-<- ******************************************************************* RPLACD intensive benchmark: -- DESTRUCTIVE ******************************************************************* ={PHYLUM}DESTRUCTIVE.DCOM;4 {PHYLUM}DESTRUCTIVE.DCOM;4 compiled on 9-FEB-83 15:37:41 FILE CREATED 9-FEB-83 15:37:32 DESTRUCTIVECOMS Commenceing on DESTRUCTIVE run: (TIMEALL (DESTRUCTIVE 600 50)) Elapsed Time = 7.2 seconds SWAP time = .184 seconds GC time = 3.2 seconds CPU Time = 3.81 seconds PAGEFAULTS = 38 DISKOPS = 12 LISTP 43105 Value = ((1 1 2) (1 1 1) (1 1 1 2) (1 1 1 1) (1 1 1 1 2) (1 1 1 1 2) (1 1 1 1 2) (1 1 1 1 2) (1 1 1 1 2) (1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 2 2 2 2 2 3)) Repeating the TIMEALL Elapsed Time = 6.57 seconds GC time = 3.04 seconds CPU Time = 3.53 seconds PAGEFAULTS = 4 LISTP 43105 Value = ((1 1 2) (1 1 1) (1 1 1 2) (1 1 1 1) (1 1 1 1 2) (1 1 1 1 2) (1 1 1 1 2) (1 1 1 1 2) (1 1 1 1 2) (1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 2 2 2 2 2 3)) Final GC-collision status: (704 35 .04971591) DESTRUCTIVE finished ->->->->->Freshly Loaded<-<-<-<- ******************************************************************* ARRAY-intensive BenchMarks -- PUZZLE, FFT, and TRIANG PUZZLE is the famous Baskett bench mark; FFT is fast-fourier transform, and is also floating-point intensive; TRIANG (??) is also cons-intensive. ******************************************************************* ={PHYLUM}PUZZLE.DCOM;10 {PHYLUM}PUZZLE.DCOM;10 compiled on 2-OCT-83 15:53:19 FILE CREATED 2-OCT-83 15:53:02 PUZZLECOMS {ERIS}HARMONY>LIBRARY>CMLARRAY.DCOM;1 compiled on 9-Sep-84 20:31:15 FILE CREATED 9-Sep-84 20:30:38 CMLARRAYCOMS Commenceing on PUZZLE run: (TIMEALL (START)) Success in 2005 trials. Elapsed Time = 15.0 seconds CPU Time = 15.0 seconds Value = NIL Repeating the TIMEALL Success in 2005 trials. Elapsed Time = 15.0 seconds CPU Time = 15.0 seconds Value = NIL PUZZLE finished ->->->->->Freshly Loaded<-<-<-<- ={PHYLUM}FFT.DCOM;6 {PHYLUM}FFT.DCOM;6 compiled on 21-OCT-83 20:48:42 FILE CREATED 21-OCT-83 20:47:56 FFTCOMS {ERIS}HARMONY>LIBRARY>CMLARRAY.DCOM;1 compiled on 9-Sep-84 20:31:15 FILE CREATED 9-Sep-84 20:30:38 CMLARRAYCOMS Commenceing on FFT run: (TIMEALL (FFT RE IM)) Elapsed Time = 6.11 seconds SWAP time = .324 seconds GC time = 3.19 seconds CPU Time = 2.6 seconds PAGEFAULTS = 60 DISKOPS = 14 FLOATP 57598 Repeating the TIMEALL Elapsed Time = 4.88 seconds GC time = 3.22 seconds CPU Time = 1.66 seconds FLOATP 57598 FFT finished ->->->->->Freshly Loaded<-<-<-<- ={PHYLUM}TRIANG.DCOM;12 {PHYLUM}TRIANG.DCOM;12 compiled on 22-May-84 20:53:02 FILE CREATED 22-May-84 20:52:42 TRIANGCOMS {ERIS}HARMONY>LIBRARY>CMLARRAY.DCOM;1 compiled on 9-Sep-84 20:31:15 FILE CREATED 9-Sep-84 20:30:38 CMLARRAYCOMS Commenceing on TRIANG run: (TIMEALL (GOGOGO 22)) Elapsed Time = 250.0 seconds GC time = .186 seconds CPU Time = 250.0 seconds PAGEFAULTS = 82 LISTP 11626 Value = NIL Repeating the TIMEALL Elapsed Time = 249.0 seconds GC time = .186 seconds CPU Time = 249.0 seconds LISTP 11626 Value = NIL TRIANG finished ->->->->->Freshly Loaded<-<-<-<- ******************************************************************* Datatype creation and Bit-hacking benchmark: TRAVERSE Creates a deeply-nested structure, which is then traced through one component; Flag fields direct the trace; simulates some of the 'Mark' of a GC. ******************************************************************* ={PHYLUM}TRAVERSE.DCOM;8 {PHYLUM}TRAVERSE.DCOM;8 compiled on 13-Jan-84 13:40:51 FILE CREATED 9-Jan-84 17:55:36 TRAVERSECOMS Commenceing on TRAVERSE initialization: (TIMEALL (SETQ ROOT (CREATE-STRUCTURE 100))) Elapsed Time = 19.9 seconds SWAP time = .092 seconds GC time = .526 seconds CPU Time = 19.3 seconds PAGEFAULTS = 426 DISKOPS = 9 LISTP NODE 36796 100 Commenceing on TRAVERSE run: (TIMEALL (TRAVERSE ROOT) 200) (TIMEDUMMYFUNCTION NIL) Elapsed Time = 51.7 seconds CPU Time = 51.7 seconds TRAVERSE finished ->->->->->Freshly Loaded<-<-<-<- ******************************************************************* DSK file I/O benchmarks: FPRINT and FREAD Terminal printing (to window): TPRINT ******************************************************************* ={PHYLUM}FPRINT.DCOM;3 {PHYLUM}FPRINT.DCOM;3 compiled on 5-JUL-83 14:30:00 FILE CREATED 5-JUL-83 14:29:33 FPRINTCOMS Commenceing on FPRINT: (TIMEALL (FPRINT)) Elapsed Time = 3.41 seconds SWAP time = .342 seconds Disk i/o time = 1.49 seconds CPU Time = 1.58 seconds PAGEFAULTS = 5 DISKOPS = 192 FIXP LISTP ARRAYP VMEMPAGEP STREAM BUFFER 1 213 4 2 2 1 Repeating the TIMEALL Elapsed Time = 3.0 seconds Disk i/o time = 1.13 seconds CPU Time = 1.87 seconds DISKOPS = 162 FIXP LISTP ARRAYP VMEMPAGEP STREAM 1 213 4 1 2 FPRINT finished ={PHYLUM}FREAD.DCOM;1 {PHYLUM}FREAD.DCOM;1 compiled on 5-JUL-83 14:36:55 FILE CREATED 5-JUL-83 14:36:33 FREADCOMS Commenceing on FREAD run: (TIMEALL (FREAD)) Elapsed Time = 1.78 seconds Disk i/o time = .54 seconds CPU Time = 1.24 seconds PAGEFAULTS = 16 DISKOPS = 37 FIXP LISTP ARRAYP VMEMPAGEP STREAM BUFFER 2 2216 4 2 1 1 Repeating the TIMEALL Elapsed Time = 1.68 seconds Disk i/o time = .47 seconds CPU Time = 1.21 seconds DISKOPS = 37 FIXP LISTP ARRAYP VMEMPAGEP STREAM BUFFER 2 2216 4 2 1 1 FREAD finished ={PHYLUM}TPRINT.DCOM;6 {PHYLUM}TPRINT.DCOM;6 compiled on 26-Jan-84 00:51:31 FILE CREATED 26-Jan-84 00:51:25 (INIT redefined) (INIT1 redefined) TPRINTCOMS Commenceing on TPRINT run: (TIMIT) Elapsed Time = 7.83 seconds CPU Time = 7.83 seconds Repeating the TIMEALL Elapsed Time = 7.83 seconds CPU Time = 7.83 seconds TPRINT finished ->->->->->Freshly Loaded<-<-<-<- ******************************************************************* Additional (non-Gabriel) benchmarks: DIVTST and TANSPEED DIVTST mimics password computations; once with 16-bit arithmetic and once with 29-bit. TANSPEED tests accuracy of SQRT, LOG, ANTILOG, TAN, and ARCTAN; [result should be 2500.0, but ~2476. is OK for 32-bit floatps] ******************************************************************* ={PHYLUM}DIVTST.DCOM;1 {PHYLUM}DIVTST.DCOM;1 compiled on 19-JUL-83 01:18:16 FILE CREATED 19-JUL-83 01:18:00 DIVTSTCOMS Commenceing on DIVTST: (QT1) -- a TIMEALL of HASH.PASSWORD.16 (TIMEDUMMYFUNCTION NIL) Elapsed Time = .678 seconds SWAP time = .024 seconds CPU Time = .654 seconds PAGEFAULTS = 1 DISKOPS = 1 Value = 9272 Commenceing on DIVTST: (QT2) -- a TIMEALL of HASH.PASSWORD.29 (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = 9.66 seconds SWAP time = .046 seconds GC time = 3.6 seconds CPU Time = 6.01 seconds PAGEFAULTS = 35 DISKOPS = 3 FIXP 63000 Value = 48775805 DIVTST finished ={PHYLUM}TANSPEED.DCOM;1 {PHYLUM}TANSPEED.DCOM;1 compiled on 18-Mar-84 00:24:50 FILE CREATED 18-Mar-84 00:24:47 TANSPEEDCOMS Commenceing on TANSPEED: (TIMEALL (TANSPEED)) Elapsed Time = 21.6 seconds SWAP time = .641 seconds GC time = 13.2 seconds CPU Time = 7.82 seconds PAGEFAULTS = 43 DISKOPS = 13 FLOATP 229903 Value = 2476.246 TANSPEED finished ->->->->->Freshly Loaded<-<-<-<- ******************************************************************* BITBLT benchmark, suggested by L. Peter Deutsch. 1) ScrollUp a 800x512 window by one pixel; 2) ScrollRight a 800x512 window by one pixel; 3) BLTing an 8x7 'character' at 500 random places on the screen; 4) Texturing a 40x40 region at 500 random places on the screen; Tests are all run once with system-level primitives, and once with user-level primitives (those whose name begins with U). Each test has two TIMEALL runs -- once for loop overhead only, and once for real. ******************************************************************* ={PHYLUM}BBTEST.DCOM;12 {PHYLUM}BBTEST.DCOM;12 compiled on 15-Apr-84 15:10:24 FILE CREATED 15-Apr-84 15:06:41 BBTESTCOMS Commenceing on BBT.SCROLLUP: (BBT.SCROLLUP 100) (TIMEDUMMYFUNCTION NIL) Elapsed Time = .002 seconds CPU Time = .002 seconds (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = 1.14 seconds CPU Time = 1.14 seconds Commenceing on UBBT.SCROLLUP: (UBBT.SCROLLUP 100) (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = .002 seconds CPU Time = .002 seconds (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = 1.19 seconds CPU Time = 1.19 seconds Commenceing on BBT.SCROLLRIGHT: (BBT.SCROLLRIGHT 100) (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = .001 seconds CPU Time = .001 seconds (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = 1.2 seconds CPU Time = 1.2 seconds Commenceing on UBBT.SCROLLRIGHT: (UBBT.SCROLLRIGHT 100) (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = .002 seconds CPU Time = .002 seconds (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = 1.26 seconds CPU Time = 1.26 seconds Commenceing on BBT.BLTCHAR: (BBT.BLTCHAR 10) (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = .126 seconds CPU Time = .126 seconds (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = .292 seconds CPU Time = .292 seconds Commenceing on UBBT.BLTCHAR: (UBBT.BLTCHAR 10) (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = .105 seconds CPU Time = .105 seconds (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = 2.0 seconds CPU Time = 2.0 seconds Commenceing on BBT.TEXTURE: (BBT.TEXTURE 10) (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = .129 seconds CPU Time = .129 seconds (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = .888 seconds CPU Time = .888 seconds Commenceing on UBBT.TEXTURE: (UBBT.TEXTURE 10) (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = .1 seconds CPU Time = .1 seconds (TIMEDUMMYFUNCTION NIL) (TIMEDUMMYFUNCTION redefined) Elapsed Time = 2.57 seconds CPU Time = 2.57 seconds Done!