Errors : 0
Warnings: 0
1 The SAS System 11:39 Friday, March 21, 2014 NOTE: Copyright (c) 2002-2010 by SAS Institute Inc., Cary, NC, USA. NOTE: SAS (r) Proprietary Software 9.3 (TS1M2) Licensed to HMS GMBH WINDOWS SERVER CLIENT 64BIT, Site 70128358. NOTE: This session is executing on the X64_7PRO platform. NOTE: Enhanced analytical products: SAS/STAT 12.1, SAS/ETS 12.1, SAS/OR 12.1, SAS/IML 12.1, SAS/QC 12.1 NOTE: SAS initialization used: real time 0.20 seconds cpu time 0.18 seconds NOTE: The macro _SCENARIO completed compilation without errors. 56 instructions 1692 bytes. MPRINT(_SCENARIO): =MAX; NOTE: The macro _INITERRORHANDLER completed compilation without errors. 24 instructions 444 bytes. MPRINT(_SCENARIO): ; NOTE: The macro _HANDLEERROR completed compilation without errors. 70 instructions 1712 bytes. NOTE: The macro _EXISTDIR completed compilation without errors. 40 instructions 824 bytes. MPRINT(_SCENARIO): LIBNAME target "c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en"; NOTE: Libref TARGET was successfully assigned as follows: Engine: V9 Physical Name: c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en NOTE: The macro _LOADENVIRONMENT completed compilation without errors. 213 instructions 7032 bytes. NOTE: The macro _NOBS completed compilation without errors. 32 instructions 640 bytes. MPRINT(_LOADENVIRONMENT): DATA _null_; MPRINT(_LOADENVIRONMENT): SET target.tsu; MPRINT(_LOADENVIRONMENT): call symput ('g_project' , tsu_project); MPRINT(_LOADENVIRONMENT): call symput ('g_root' , tsu_root); MPRINT(_LOADENVIRONMENT): call symput ('g_sasunitroot' , tsu_sasunitroot); MPRINT(_LOADENVIRONMENT): call symput ('g_sasunit' , tsu_sasunit); MPRINT(_LOADENVIRONMENT): call symput ('g_sasunit_os' , tsu_sasunit_os); MPRINT(_LOADENVIRONMENT): call symput ('g_sasautos' , tsu_sasautos); MPRINT(_LOADENVIRONMENT): call symput ('g_sasautos0' , tsu_sasautos); MPRINT(_LOADENVIRONMENT): call symput ("g_sasautos1" , tsu_sasautos1); MPRINT(_LOADENVIRONMENT): call symput ("g_sasautos2" , tsu_sasautos2); MPRINT(_LOADENVIRONMENT): call symput ("g_sasautos3" , tsu_sasautos3); MPRINT(_LOADENVIRONMENT): call symput ("g_sasautos4" , tsu_sasautos4); MPRINT(_LOADENVIRONMENT): call symput ("g_sasautos5" , tsu_sasautos5); MPRINT(_LOADENVIRONMENT): call symput ("g_sasautos6" , tsu_sasautos6); MPRINT(_LOADENVIRONMENT): call symput ("g_sasautos7" , tsu_sasautos7); MPRINT(_LOADENVIRONMENT): call symput ("g_sasautos8" , tsu_sasautos8); MPRINT(_LOADENVIRONMENT): call symput ("g_sasautos9" , tsu_sasautos9); MPRINT(_LOADENVIRONMENT): call symput ('g_autoexec' , tsu_autoexec); MPRINT(_LOADENVIRONMENT): call symput ('g_sascfg' , tsu_sascfg); MPRINT(_LOADENVIRONMENT): call symput ('g_sasuser' , tsu_sasuser); 2 The SAS System 11:39 Friday, March 21, 20 MPRINT(_LOADENVIRONMENT): call symput ('g_testdata' , tsu_testdata); MPRINT(_LOADENVIRONMENT): call symput ('g_refdata' , tsu_refdata); MPRINT(_LOADENVIRONMENT): call symput ('g_doc' , tsu_doc); MPRINT(_LOADENVIRONMENT): call symput ('g_testcoverage', put (tsu_testcoverage, z1.)); MPRINT(_LOADENVIRONMENT): call symput ('g_verbose' , put (tsu_verbose, z1.)); MPRINT(_LOADENVIRONMENT): RUN; NOTE: There were 1 observations read from the data set TARGET.TSU. NOTE: DATA statement used (Total process time): real time 0.01 seconds cpu time 0.01 seconds NOTE: The macro _ABSPATH completed compilation without errors. 54 instructions 1224 bytes. NOTE: The macro _DETECTSYMBOLS completed compilation without errors. 39 instructions 1268 bytes. MPRINT(_DETECTSYMBOLS): proc printto log=work.detect.note.log new; MPRINT(_DETECTSYMBOLS): run; NOTE: PROCEDURE PRINTTO used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(_DETECTSYMBOLS): filename _detect catalog "work.detect.note.log"; MPRINT(_DETECTSYMBOLS): data _null_; MPRINT(_DETECTSYMBOLS): infile _detect truncover; MPRINT(_DETECTSYMBOLS): input line $char256.; MPRINT(_DETECTSYMBOLS): call symput ("g_note", scan(line, 1, ':')); MPRINT(_DETECTSYMBOLS): stop; MPRINT(_DETECTSYMBOLS): run; NOTE: The infile _DETECT is: Catalog Name=WORK.DETECT.NOTE.LOG, Catalog Page Size=4096, Number of Catalog Pages=4, Created=Freitag, 21. März 2014 11.39 Uhr, Last Modified=Freitag, 21. März 2014 11.39 Uhr, Filename=C:\Users\REDMIN~1\AppData\Local\Temp\SAS Temporary Files\_TD3256_HD1PCMS0104_\detect.sas7bcat, Release Created=9.0301M2,Host Created=X64_7PRO NOTE: 1 record was read from the infile _DETECT. The minimum record length was 50. The maximum record length was 50. NOTE: DATA statement used (Total process time): 3 The SAS System 11:39 Friday, March 21, 20 real time 0.00 seconds cpu time 0.00 seconds MPRINT(_DETECTSYMBOLS): filename _detect; NOTE: Fileref _DETECT has been deassigned. MPRINT(_DETECTSYMBOLS): proc datasets lib=work nolist; MPRINT(_DETECTSYMBOLS): delete detect / memtype=catalog; MPRINT(_DETECTSYMBOLS): quit; NOTE: Deleting WORK.DETECT (memtype=CATALOG). NOTE: PROCEDURE DATASETS used (Total process time): real time 0.01 seconds cpu time 0.01 seconds MPRINT(_LOADENVIRONMENT): LIBNAME testout "c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/tst"; NOTE: Libref TESTOUT was successfully assigned as follows: Engine: V9 Physical Name: c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en\tst MPRINT(_LOADENVIRONMENT): FILENAME testout "c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/tst"; MPRINT(_LOADENVIRONMENT): LIBNAME testdata "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/dat"; NOTE: Libref TESTDATA was successfully assigned as follows: Engine: V9 Physical Name: c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\dat MPRINT(_LOADENVIRONMENT): FILENAME testdata "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/dat"; MPRINT(_LOADENVIRONMENT): LIBNAME refdata "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/dat"; NOTE: Libname REFDATA refers to the same physical library as TESTDATA. NOTE: Libref REFDATA was successfully assigned as follows: Engine: V9 Physical Name: c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\dat MPRINT(_LOADENVIRONMENT): FILENAME refdata "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/dat"; GLOBAL G_SASUSER GLOBAL G_TESTDATA c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\dat GLOBAL G_AUTOEXEC GLOBAL G_DOC GLOBAL G_ERROR ERROR GLOBAL G_PRINTFILE GLOBAL G_ERROR_CODE GLOBAL G_ERROR_MSG GLOBAL G_ERROR_MACRO GLOBAL G_ROOT c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3 GLOBAL G_TESTOUT c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/tst GLOBAL G_LOG c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/log GLOBAL G_SASCFG c:.jenkinsjobsSASUnit Build Release ZIPFileworkspacev1.3/examplebinsasunit.9.3.windows.en.cfg GLOBAL G_SASAUTOS c:.jenkinsjobsSASUnit Build Release ZIPFileworkspacev1.3/examplesaspgm GLOBAL G_SASAUTOS0 c:.jenkinsjobsSASUnit Build Release ZIPFileworkspacev1.3/examplesaspgm GLOBAL G_SASAUTOS1 GLOBAL G_SASAUTOS2 GLOBAL G_SASAUTOS3 GLOBAL G_SASAUTOS4 GLOBAL G_SASAUTOS5 GLOBAL G_SASAUTOS6 GLOBAL G_SASAUTOS7 4 The SAS System 11:39 Friday, March 21, 20 GLOBAL G_SASAUTOS8 GLOBAL G_SASAUTOS9 GLOBAL G_NOTE NOTE GLOBAL G_VERBOSE 1 GLOBAL G_REFDATA c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\dat GLOBAL G_TESTCOVERAGE 1 GLOBAL G_TARGET c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en GLOBAL G_WARNING WARNING GLOBAL G_PROJECT SASUnit Examples GLOBAL G_SASUNIT c:.jenkinsjobsSASUnit Build Release ZIPFileworkspacev1.3/saspgmsasunit GLOBAL G_SASUNIT_OS c:.jenkinsjobsSASUnit Build Release ZIPFileworkspacev1.3/saspgmsasunitwindows GLOBAL G_WORK C:\Users\REDMIN~1\AppData\Local\Temp\SAS Temporary Files\_TD3256_HD1PCMS0104_ GLOBAL G_LOGFILE GLOBAL G_SASUNITROOT c:.jenkinsjobsSASUnit Build Release ZIPFileworkspacev1.3 MPRINT(_LOADENVIRONMENT): OPTIONS MAUTOSOURCE SASAUTOS=(SASAUTOS "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/saspgm/sasunit" "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/saspgm/sasunit/windows" "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/saspgm" ); NOTE: The macro _OSCMDS completed compilation without errors. 35 instructions 808 bytes. MPRINT(_SCENARIO): ; 1 /** 2 \file 3 \ingroup SASUNIT_EXAMPLES_TEST 4 5 \brief Tests for regression.sas 6 7 Example for a test scenario with the following features: 8 - check reports manually agains reference standard 9 - compare results from Microsoft Excel with assertColumns.sas, using fuzz because of rounding errors 10 - use test data in library testdata 11 12 This example test scenario runs only with SAS under SAS Microsoft Windows. 13 14 \version \$Revision: 315 $ - KL: Removed hint "Windows only".\n 15 Revision: 71 - KL: Test case can now be run under LINUX. 16 \author \$Author: klandwich $ 17 \date \$Date: 2014-02-28 10:25:18 +0100 (Fr, 28 Feb 2014) $ 18 \sa For further information please refer to <A href="https://sourceforge.net/p/sasunit/wiki/User's%20Guide/" target="_blank">SASUnit User's Guide</A> 19 \sa \$HeadURL: https://svn.code.sf.net/p/sasunit/code/trunk/example/saspgm/regression_test.sas $ 20 \copyright Copyright 2010, 2012 HMS Analytical Software GmbH. 21 This file is part of SASUnit, the Unit testing framework for SAS(R) programs. 22 For terms of usage under the GPL license see included file readme.txt 23 or https://sourceforge.net/p/sasunit/wiki/readme.v1.2/. 24 */ /** \cond */ 25 26 /*-- Compare linear regression between Excel and SAS -------------------------*/ 27 28 %initTestcase(i_object=regression.sas, i_desc=compare linear regression between Excel and SAS) NOTE: The macro INITTESTCASE completed compilation without errors. 99 instructions 2784 bytes. NOTE: The macro LOWCASE completed compilation without errors. 29 instructions 504 bytes. NOTE: The macro _GETAUTOCALLNUMBER completed compilation without errors. 61 instructions 1180 bytes. MPRINT(INITTESTCASE): PROC SQL NOPRINT; 5 The SAS System 11:39 Friday, March 21, 20 MPRINT(INITTESTCASE): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid = 006; MPRINT(INITTESTCASE): INSERT INTO target.cas VALUES ( 006 ,1 ,2 ,"regression.sas" ,"compare linear regression between Excel and SAS" , MPRINT(INITTESTCASE): "" ,1711021195.683 ,. ,. ); NOTE: 1 row was inserted into TARGET.CAS. MPRINT(INITTESTCASE): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds ========================== test case 1 ====================================================== MPRINT(INITTESTCASE): PROC PRINTTO NEW LOG="c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/log/006_001.log" PRINT="c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/tst/006_001.lst" ; MPRINT(INITTESTCASE): RUN; NOTE: PROCEDURE PRINTTO used (Total process time): 7 The SAS System 11:39 Friday, March 21, 20 real time 0.04 seconds cpu time 0.04 seconds MPRINT(ENDTESTCALL): PROC SQL NOPRINT; MPRINT(ENDTESTCALL): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid=006; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(ENDTESTCALL): PROC SQL NOPRINT; MPRINT(ENDTESTCALL): UPDATE target.cas SET cas_end = 1711021196.193 WHERE cas_scnid = 006 AND cas_id = 1; NOTE: 1 row was updated in TARGET.CAS. MPRINT(ENDTESTCALL): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(ENDTESTCALL): PROC SQL NOPRINT; MPRINT(ENDTESTCALL): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid=006; MPRINT(ENDTESTCALL): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(ENDTESTCALL): DATA _null_; MPRINT(ENDTESTCALL): INFILE "c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/tst/006_001.lst"; MPRINT(ENDTESTCALL): INPUT; MPRINT(ENDTESTCALL): CALL symput ('l_filled','1'); MPRINT(ENDTESTCALL): STOP; MPRINT(ENDTESTCALL): RUN; NOTE: The infile "c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/tst/006_001.lst" is: Filename=c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en\tst\006_001.lst, RECFM=V,LRECL=256,File Size (bytes)=0, Last Modified=21. März 2014 11.39 Uhr, Create Time=21. März 2014 11.39 Uhr NOTE: 0 records were read from the infile "c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/tst/006_001.lst". NOTE: DATA statement used (Total process time): real time 0.00 seconds cpu time 0.00 seconds NOTE: The macro _DELFILE completed compilation without errors. 26 instructions 552 bytes. MPRINT(ENDTESTCALL): ODS _ALL_ CLOSE; MPRINT(ASSERTREPORT): ; NOTE: The macro _GETEXTENSION completed compilation without errors. 26 instructions 504 bytes. 8 The SAS System 11:39 Friday, March 21, 20 NOTE: The macro _TEMPFILENAME completed compilation without errors. 29 instructions 720 bytes. MPRINT(_TEMPFILENAME): DATA; MPRINT(_TEMPFILENAME): STOP; MPRINT(_TEMPFILENAME): RUN; NOTE: The data set WORK.DATA1 has 0 observations and 0 variables. NOTE: DATA statement used (Total process time): real time 0.00 seconds cpu time 0.00 seconds NOTE(SASUNIT): Temporary dataset &d_dir is WORK.DATA1 MPRINT(_TEMPFILENAME): PROC SQL NOPRINT; MPRINT(_TEMPFILENAME): DROP TABLE WORK.DATA1; NOTE: Table WORK.DATA1 has been dropped. MPRINT(_TEMPFILENAME): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds NOTE: The macro _DIR completed compilation without errors. 88 instructions 3920 bytes. MPRINT(_DIR): proc sql noprint; MPRINT(_DIR): create table WORK.DATA1 (filename char(255)); NOTE: Table WORK.DATA1 created, with 0 rows and 1 columns. MPRINT(_DIR): quit; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(_DIR): options noxwait xsync xmin; MPRINT(_DIR): filename _dirfile "C:\Users\REDMIN~1\AppData\Local\Temp\SAS Temporary Files\_TD3256_HD1PCMS0104_\___dir.txt" encoding=pcoem850; NOTE(SASUNIT): Directory search is: C:\Users\REDMIN~1\AppData\Local\Temp\SAS Temporary Files\_TD3256_HD1PCMS0104_/report1.rtf MPRINT(_DIR): options XWAIT XSYNC NOXMIN; MPRINT(_DIR): data WORK.DATA1 (keep=filename changed); MPRINT(_DIR): length dir filename $255 language $2; MPRINT(_DIR): retain language "__" dir FilePos; MPRINT(_DIR): infile _dirfile truncover; MPRINT(_DIR): input line $char255. @; MPRINT(_DIR): if index (line, "Directory of") or index (line, "Verzeichnis von") then do; MPRINT(_DIR): if index (line, "Directory of") then do; MPRINT(_DIR): dir = substr(line, index (line, "Directory of")+length("Directory of")+1); MPRINT(_DIR): end; MPRINT(_DIR): else do; MPRINT(_DIR): dir = substr(line, index (line, "Verzeichnis von")+length("Verzeichnis von")+1); MPRINT(_DIR): end; MPRINT(_DIR): end; MPRINT(_DIR): if substr(line,1,1) ne ' ' then do; MPRINT(_DIR): * Check for presence of AM/PM in time value, because you can specify AM/PM timeformat in German Windows *; MPRINT(_DIR): if (language = "__") then do; MPRINT(_DIR): Detect_AM_PM = upcase (scan (line, 3, " ")); 9 The SAS System 11:39 Friday, March 21, 20 MPRINT(_DIR): if (Detect_AM_PM in ("AM", "PM")) then do; MPRINT(_DIR): Filenamepart = scan (line,5, " "); MPRINT(_DIR): Filepos = index (line, trim(Filenamepart)); MPRINT(_DIR): language = "EN"; MPRINT(_DIR): end; MPRINT(_DIR): else do; MPRINT(_DIR): Filenamepart = scan (line,4, " "); MPRINT(_DIR): Filepos = index (line, trim(Filenamepart)); MPRINT(_DIR): language = "DE"; MPRINT(_DIR): end; MPRINT(_DIR): end; MPRINT(_DIR): if language='DE' then do; MPRINT(_DIR): input @1 d ddmmyy10. +2 t time5. ; MPRINT(_DIR): end; MPRINT(_DIR): else do; MPRINT(_DIR): input @1 d mmddyy10. +2 t time9. ; MPRINT(_DIR): end; MPRINT(_DIR): changed = dhms (d, hour(t), minute(t), 0); MPRINT(_DIR): format changed datetime20.; MPRINT(_DIR): filename = translate(trim(dir) !! '/' !! substr (line,FilePos),'/','\'); MPRINT(_DIR): output; MPRINT(_DIR): end; MPRINT(_DIR): run; NOTE: The infile _DIRFILE is: Filename=C:\Users\REDMIN~1\AppData\Local\Temp\SAS Temporary Files\_TD3256_HD1PCMS0104_\___dir.txt, RECFM=V,LRECL=256,File Size (bytes)=339, Last Modified=21. März 2014 11.39 Uhr, Create Time=21. März 2014 11.39 Uhr NOTE: 8 records were read from the infile _DIRFILE. The minimum record length was 0. The maximum record length was 94. NOTE: The data set WORK.DATA1 has 1 observations and 2 variables. NOTE: DATA statement used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(_DIR): filename _dirfile; NOTE: Fileref _DIRFILE has been deassigned. MPRINT(ASSERTREPORT): data _null_; MPRINT(ASSERTREPORT): set WORK.DATA1 nobs=nobs; MPRINT(ASSERTREPORT): if nobs ne 1 then stop; MPRINT(ASSERTREPORT): if changed < dhms (today(), hour (input ("11:39",time5.)), minute (input ("11:39",time5.)), 0) then do; MPRINT(ASSERTREPORT): stop; MPRINT(ASSERTREPORT): end; MPRINT(ASSERTREPORT): call symput ('l_result', '1'); MPRINT(ASSERTREPORT): stop; MPRINT(ASSERTREPORT): run; NOTE: There were 1 observations read from the data set WORK.DATA1. NOTE: DATA statement used (Total process time): real time 0.00 seconds 10 The SAS System 11:39 Friday, March 21, 20 cpu time 0.00 seconds MPRINT(ASSERTREPORT): proc sql; MPRINT(ASSERTREPORT): drop table WORK.DATA1; NOTE: Table WORK.DATA1 has been dropped. MPRINT(ASSERTREPORT): quit; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds NOTE: The macro _GETSCENARIOTESTID completed compilation without errors. 137 instructions 3692 bytes. MPRINT(_GETSCENARIOTESTID): PROC SQL NOPRINT; MPRINT(_GETSCENARIOTESTID): *** determine number of the current test case ****; MPRINT(_GETSCENARIOTESTID): SELECT max(cas_id) INTO :l_casid_gti FROM target.cas WHERE cas_scnid = 006; MPRINT(_GETSCENARIOTESTID): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(_GETSCENARIOTESTID): PROC SQL NOPRINT; MPRINT(_GETSCENARIOTESTID): *** determine number of the current test case ****; MPRINT(_GETSCENARIOTESTID): SELECT max(tst_id) INTO :l_tstid_gti FROM target.tst WHERE tst_scnid = 006 AND tst_casid= 1; MPRINT(_GETSCENARIOTESTID): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.01 seconds cpu time 0.01 seconds MPRINT(ASSERTREPORT): ; NOTE: The macro _CREATETESTSUBFOLDER completed compilation without errors. 65 instructions 1848 bytes. NOTE: The macro _GETTESTSUBFOLDER completed compilation without errors. 112 instructions 2920 bytes. MPRINT(_CREATETESTSUBFOLDER): ; NOTE: The macro _MKDIR completed compilation without errors. 26 instructions 616 bytes. MPRINT(_MKDIR): options noxwait xsync xmin; MPRINT(_MKDIR): options XWAIT XSYNC NOXMIN; MPRINT(_CREATETESTSUBFOLDER): ; MPRINT(ASSERTREPORT): ; NOTE: The macro _COPYFILE completed compilation without errors. 9 instructions 404 bytes. MPRINT(_COPYFILE): DATA _null_; MPRINT(_COPYFILE): INFILE "C:\Users\REDMIN~1\AppData\Local\Temp\SAS Temporary Files\_TD3256_HD1PCMS0104_/report1.rtf" RECFM=N LRECL=1048576 LENGTH=l SHAREBUFFERS BLKSIZE=32768; MPRINT(_COPYFILE): FILE "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/doc/sasunit/en/tst/_006_001_001_assertreport/_man_act.rtf" RECFM=N LRECL=32768 BLKSIZE=1048576; MPRINT(_COPYFILE): INPUT line $char32767.; MPRINT(_COPYFILE): PUT line $varying32767. l; MPRINT(_COPYFILE): RUN; NOTE: UNBUFFERED is the default with RECFM=N. 11 The SAS System 11:39 Friday, March 21, 20 NOTE: The infile "C:\Users\REDMIN~1\AppData\Local\Temp\SAS Temporary Files\_TD3256_HD1PCMS0104_/report1.rtf" is: Filename=C:\Users\REDMIN~1\AppData\Local\Temp\SAS Temporary Files\_TD3256_HD1PCMS0104_\report1.rtf, RECFM=N,LRECL=1048576,File Size (bytes)=55313, Last Modified=21. März 2014 11.39 Uhr, Create Time=21. März 2014 11.39 Uhr NOTE: UNBUFFERED is the default with RECFM=N. NOTE: The file "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/doc/sasunit/en/tst/_006_001_001_assertreport/_man_act.rtf" is: Filename=c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en\tst\_006_001_001_assertreport\_man_act.rtf, RECFM=N,LRECL=32768,File Size (bytes)=0, Last Modified=21. März 2014 11.39 Uhr, Create Time=21. März 2014 11.39 Uhr NOTE: DATA statement used (Total process time): real time 0.06 seconds cpu time 0.01 seconds MPRINT(ASSERTREPORT): ; MPRINT(_COPYFILE): DATA _null_; MPRINT(_COPYFILE): INFILE "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/dat/regression.xls" RECFM=N LRECL=1048576 LENGTH=l SHAREBUFFERS BLKSIZE=32768; MPRINT(_COPYFILE): FILE "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/doc/sasunit/en/tst/_006_001_001_assertreport/_man_exp.xls" RECFM=N LRECL=32768 BLKSIZE=1048576; MPRINT(_COPYFILE): INPUT line $char32767.; MPRINT(_COPYFILE): PUT line $varying32767. l; MPRINT(_COPYFILE): RUN; NOTE: UNBUFFERED is the default with RECFM=N. NOTE: The infile "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/dat/regression.xls" is: Filename=c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\dat\regression.xls, RECFM=N,LRECL=1048576,File Size (bytes)=38912, Last Modified=21. März 2014 11.39 Uhr, Create Time=21. März 2014 11.39 Uhr NOTE: UNBUFFERED is the default with RECFM=N. NOTE: The file "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/doc/sasunit/en/tst/_006_001_001_assertreport/_man_exp.xls" is: Filename=c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en\tst\_006_001_001_assertreport\_man_exp.xls, RECFM=N,LRECL=32768,File Size (bytes)=0, Last Modified=21. März 2014 11.39 Uhr, Create Time=21. März 2014 11.39 Uhr NOTE: DATA statement used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(ASSERTREPORT): ; NOTE: The macro _ASSERTS completed compilation without errors. 152 instructions 4104 bytes. NOTE(SASUNIT): assertReport: assert passed, but manual check necessary. MPRINT(_ASSERTS): PROC SQL NOPRINT; MPRINT(_ASSERTS): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid=006; MPRINT(_ASSERTS): SELECT max(tst_id) INTO :l_tstid FROM target.tst WHERE tst_scnid = 006 AND tst_casid = 1 ; MPRINT(_ASSERTS): INSERT INTO target.tst VALUES ( 006 , 1 ,1 ,"assertReport" ,"please compare SAS chart with Excel chart " ,".xls " ,".rtf " ,1 ,"assertReport: assert passed, but manual check necessary." ); NOTE: 1 row was inserted into TARGET.TST. 12 The SAS System 11:39 Friday, March 21, 20 MPRINT(_ASSERTS): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds ========================== Check 1.1 (assertReport) ===================================== 54 55 %assertColumns(i_actual=aus, i_expected=refdata, i_desc=compare estimated values, i_fuzz=1E-10) NOTE: The macro ASSERTCOLUMNS completed compilation without errors. 328 instructions 9428 bytes. MPRINT(_GETSCENARIOTESTID): PROC SQL NOPRINT; MPRINT(_GETSCENARIOTESTID): *** determine number of the current test case ****; MPRINT(_GETSCENARIOTESTID): SELECT max(cas_id) INTO :l_casid_gti FROM target.cas WHERE cas_scnid = 006; MPRINT(_GETSCENARIOTESTID): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(_GETSCENARIOTESTID): PROC SQL NOPRINT; MPRINT(_GETSCENARIOTESTID): *** determine number of the current test case ****; MPRINT(_GETSCENARIOTESTID): SELECT max(tst_id) INTO :l_tstid_gti FROM target.tst WHERE tst_scnid = 006 AND tst_casid= 1; MPRINT(_GETSCENARIOTESTID): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(ASSERTCOLUMNS): ; MPRINT(_CREATETESTSUBFOLDER): ; MPRINT(_MKDIR): options noxwait xsync xmin; MPRINT(_MKDIR): options XWAIT XSYNC NOXMIN; MPRINT(_CREATETESTSUBFOLDER): ; MPRINT(ASSERTCOLUMNS): ; MPRINT(ASSERTCOLUMNS): libname _acLib "c:/.jenkins/jobs/SASUnit Build Release ZIP-File/workspace/v1.3/example/doc/sasunit/en/tst/_006_001_002_assertcolumns"; NOTE: Libref _ACLIB was successfully assigned as follows: Engine: V9 Physical Name: c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en\tst\_006_001_002_assertcolumns MPRINT(ASSERTCOLUMNS): OPTIONS FORMCHAR="|----|+|---+=|-/\<>*"; MPRINT(ASSERTCOLUMNS): OPTIONS ORIENTATION=portrait; MPRINT(ASSERTCOLUMNS): ODS DOCUMENT NAME=_acLib._columns_rep(WRITE); MPRINT(ASSERTCOLUMNS): TITLE; MPRINT(ASSERTCOLUMNS): FOOTNOTE; MPRINT(ASSERTCOLUMNS): PROC COMPARE BASE=refdata COMPARE=aus CRITERION=1E-10 METHOD=ABSOLUTE ; MPRINT(ASSERTCOLUMNS): RUN; NOTE: There were 10 observations read from the data set WORK.REFDATA. NOTE: There were 10 observations read from the data set WORK.AUS. NOTE: PROCEDURE COMPARE used (Total process time): real time 0.01 seconds cpu time 0.01 seconds NOTE(SASUNIT): sysinfo = 32 MPRINT(ASSERTCOLUMNS): ODS DOCUMENT CLOSE; MPRINT(ASSERTCOLUMNS): OPTIONS FORMCHAR="‚ƒ„…†‡ˆ‰Š‹Œ+=|-/\<>*"; 13 The SAS System 11:39 Friday, March 21, 2014 MPRINT(ASSERTCOLUMNS): OPTIONS ORIENTATION=PORTRAIT; NOTE(SASUNIT): assertColumns: assert passed. MPRINT(_ASSERTS): PROC SQL NOPRINT; MPRINT(_ASSERTS): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid=006; MPRINT(_ASSERTS): SELECT max(tst_id) INTO :l_tstid FROM target.tst WHERE tst_scnid = 006 AND tst_casid = 1 ; MPRINT(_ASSERTS): INSERT INTO target.tst VALUES ( 006 , 1 ,2 ,"assertColumns" ,"compare estimated values " ,"DSLABEL LABEL COMPVAR " ,"LABEL " ,0 ,"assertColumns: assert passed." ); NOTE: 1 row was inserted into TARGET.TST. MPRINT(_ASSERTS): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds ========================== Check 1.2 (assertColumns) ===================================== MPRINT(ASSERTCOLUMNS): ; MPRINT(ASSERTCOLUMNS): DATA _acLib._columns_exp; MPRINT(ASSERTCOLUMNS): SET refdata (obs=max); MPRINT(ASSERTCOLUMNS): RUN; NOTE: There were 10 observations read from the data set WORK.REFDATA. NOTE: The data set _ACLIB._COLUMNS_EXP has 10 observations and 3 variables. NOTE: DATA statement used (Total process time): real time 0.06 seconds cpu time 0.03 seconds MPRINT(ASSERTCOLUMNS): DATA _acLib._columns_act; MPRINT(ASSERTCOLUMNS): SET aus (obs=max); MPRINT(ASSERTCOLUMNS): RUN; NOTE: There were 10 observations read from the data set WORK.AUS. NOTE: The data set _ACLIB._COLUMNS_ACT has 10 observations and 3 variables. NOTE: DATA statement used (Total process time): real time 0.01 seconds cpu time 0.01 seconds MPRINT(ASSERTCOLUMNS): libname _acLib; NOTE: Libref _ACLIB has been deassigned. 56 57 %assertEquals(i_actual=&intercept_xls, i_expected=&intercept_sas, i_desc=compare 57 ! intercept parameter) NOTE: The macro ASSERTEQUALS completed compilation without errors. 99 instructions 2452 bytes. NOTE(SASUNIT): assertEquals: assert passed. MPRINT(_ASSERTS): PROC SQL NOPRINT; MPRINT(_ASSERTS): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid=006; MPRINT(_ASSERTS): SELECT max(tst_id) INTO :l_tstid FROM target.tst WHERE tst_scnid = 006 AND tst_casid = 1 ; MPRINT(_ASSERTS): INSERT INTO target.tst VALUES ( 006 , 1 ,3 ,"assertEquals" ,"compare intercept parameter " ,"2 " ,"2 " ,0 ,"assertEquals: assert passed." ); NOTE: 1 row was inserted into TARGET.TST. MPRINT(_ASSERTS): QUIT; NOTE: PROCEDURE SQL used (Total process time): 14 The SAS System 11:39 Friday, March 21, 2014 real time 0.00 seconds cpu time 0.00 seconds ========================== Check 1.3 (assertEquals) ===================================== 58 %assertEquals(i_actual=&slope_xls, i_expected=&slope_sas, i_desc=compare slope 58 ! parameter) NOTE(SASUNIT): assertEquals: assert passed. MPRINT(_ASSERTS): PROC SQL NOPRINT; MPRINT(_ASSERTS): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid=006; MPRINT(_ASSERTS): SELECT max(tst_id) INTO :l_tstid FROM target.tst WHERE tst_scnid = 006 AND tst_casid = 1 ; MPRINT(_ASSERTS): INSERT INTO target.tst VALUES ( 006 , 1 ,4 ,"assertEquals" ,"compare slope parameter " ,"0.5454545455 " ,"0.5454545455 " ,0 ,"assertEquals: assert passed." ); NOTE: 1 row was inserted into TARGET.TST. MPRINT(_ASSERTS): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds ========================== Check 1.4 (assertEquals) ===================================== 59 %assertPerformance(i_expected=5, i_desc=regression calculation should be done within 5 59 ! seconds.) NOTE: The macro ASSERTPERFORMANCE completed compilation without errors. 60 instructions 1972 bytes. MPRINT(ASSERTPERFORMANCE): PROC SQL NOPRINT; MPRINT(ASSERTPERFORMANCE): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid=006; MPRINT(ASSERTPERFORMANCE): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(ASSERTPERFORMANCE): PROC SQL NOPRINT; MPRINT(ASSERTPERFORMANCE): SELECT cas_end - cas_start INTO: l_cas_runtime FROM target.cas WHERE cas_scnid = 006 AND cas_id = 1; MPRINT(ASSERTPERFORMANCE): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds NOTE(SASUNIT): assertPerformance: assert passed. MPRINT(_ASSERTS): PROC SQL NOPRINT; MPRINT(_ASSERTS): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid=006; MPRINT(_ASSERTS): SELECT max(tst_id) INTO :l_tstid FROM target.tst WHERE tst_scnid = 006 AND tst_casid = 1 ; MPRINT(_ASSERTS): INSERT INTO target.tst VALUES ( 006 , 1 ,5 ,"assertPerformance" ,"regression calculation should be done within 5 seconds. " ,"5 " ,"0.51 " ,0 ,"assertPerformance: assert passed." ); NOTE: 1 row was inserted into TARGET.TST. MPRINT(_ASSERTS): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds 15 The SAS System 11:39 Friday, March 21, 2014 ========================== Check 1.5 (assertPerformance) ===================================== 60 61 /** \endcond */ NOTE: The macro _TERMSCENARIO completed compilation without errors. 26 instructions 520 bytes. NOTE: The macro ENDTESTCASE completed compilation without errors. 71 instructions 2048 bytes. MPRINT(ENDTESTCASE): PROC SQL NOPRINT; MPRINT(ENDTESTCASE): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid=006; MPRINT(ENDTESTCASE): SELECT count(*) INTO :l_assertLog FROM target.tst WHERE tst_scnid = 006 AND tst_casid = 1 AND tst_type='assertLog'; NOTE: The macro ASSERTLOG completed compilation without errors. 71 instructions 2420 bytes. NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(ASSERTLOG): PROC SQL NOPRINT; MPRINT(ASSERTLOG): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid = 006; MPRINT(ASSERTLOG): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.01 seconds cpu time 0.01 seconds NOTE: The macro _CHECKLOG completed compilation without errors. 32 instructions 1844 bytes. MPRINT(_CHECKLOG): DATA _null_; MPRINT(_CHECKLOG): INFILE "c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/log/006_001.log" TRUNCOVER end=eof; MPRINT(_CHECKLOG): INPUT logline $char255.; MPRINT(_CHECKLOG): ATTRIB _errorPatternId LENGTH = 8 _ignoreErrPatternId LENGTH = 8 _warningPatternId LENGTH = 8 _errcount LENGTH = 8 _warncount LENGTH = 8 ; MPRINT(_CHECKLOG): RETAIN _errorPatternId 0 _ignoreErrPatternId 0 _warningPatternId 0 _errcount 0 _warncount 0 ; MPRINT(_CHECKLOG): IF _n_=1 THEN DO; MPRINT(_CHECKLOG): _errorPatternId = prxparse("/^ERROR[: ]/"); MPRINT(_CHECKLOG): _warningPatternId = prxparse("/^WARNING[: ]/"); MPRINT(_CHECKLOG): _ignoreErrPatternId = prxparse("/^ERROR: Errors printed on page/"); MPRINT(_CHECKLOG): END; MPRINT(_CHECKLOG): IF prxmatch (_errorPatternId, logline) AND (NOT prxmatch (_ignoreErrPatternId, logline)) THEN DO; MPRINT(_CHECKLOG): _errcount = _errcount+1; MPRINT(_CHECKLOG): END; MPRINT(_CHECKLOG): ELSE IF prxmatch (_warningPatternId, logline) THEN DO; MPRINT(_CHECKLOG): _warncount = _warncount+1; MPRINT(_CHECKLOG): END; MPRINT(_CHECKLOG): IF eof THEN DO; MPRINT(_CHECKLOG): CALL symputx ("l_error_count" , put(_errcount,8.)); MPRINT(_CHECKLOG): CALL symputx ("l_warning_count", put(_warncount,8.)); MPRINT(_CHECKLOG): END; MPRINT(_CHECKLOG): RUN; 16 The SAS System 11:39 Friday, March 21, 2014 NOTE: The infile "c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/log/006_001.log" is: Filename=c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en\log\006_001.log, RECFM=V,LRECL=256,File Size (bytes)=4195, Last Modified=21. März 2014 11.39 Uhr, Create Time=21. März 2014 11.39 Uhr NOTE: 93 records were read from the infile "c:\.jenkins\jobs\SASUnit Build Release ZIP-File\workspace\v1.3\example\doc\sasunit\en/log/006_001.log". The minimum record length was 0. The maximum record length was 256. One or more lines were truncated. NOTE: DATA statement used (Total process time): real time 0.00 seconds cpu time 0.00 seconds NOTE(SASUNIT): assertLog: assert passed. MPRINT(_ASSERTS): PROC SQL NOPRINT; MPRINT(_ASSERTS): SELECT max(cas_id) INTO :l_casid FROM target.cas WHERE cas_scnid=006; MPRINT(_ASSERTS): SELECT max(tst_id) INTO :l_tstid FROM target.tst WHERE tst_scnid = 006 AND tst_casid = 1 ; MPRINT(_ASSERTS): INSERT INTO target.tst VALUES ( 006 , 1 ,6 ,"assertLog" ,"Scan log for errors " ,"0#0 " ,"0#0 " ,0 ,"assertLog: assert passed." ); NOTE: 1 row was inserted into TARGET.TST. MPRINT(_ASSERTS): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds ========================== Check 1.6 (assertLog) ===================================== MPRINT(ENDTESTCASE): QUIT; MPRINT(ENDTESTCASE): PROC SQL NOPRINT; MPRINT(ENDTESTCASE): SELECT max (tst_res) INTO :l_result FROM target.tst WHERE tst_scnid=006 AND tst_casid=1; MPRINT(ENDTESTCASE): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.00 seconds cpu time 0.00 seconds MPRINT(ENDTESTCASE): PROC SQL NOPRINT; MPRINT(ENDTESTCASE): UPDATE target.cas SET cas_res = 1 WHERE cas_scnid = 006 AND cas_id = 1; NOTE: 1 row was updated in TARGET.CAS. MPRINT(ENDTESTCASE): QUIT; NOTE: PROCEDURE SQL used (Total process time): real time 0.06 seconds cpu time 0.00 seconds MPRINT(_TERMSCENARIO): ; NOTE: SAS Institute Inc., SAS Campus Drive, Cary, NC USA 27513-2414 17 The SAS System 11:39 Friday, March 21, 2014 NOTE: The SAS System used: real time 1.34 seconds cpu time 0.87 seconds