Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo", uses=false)
Using package Buildings with version 11.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|per.PEleMax|per.PEleMin|assPow.PEleDem|assPow.assMesP.u|assPow.assMesDP.u",fileNamePrefix="Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower")
translateModel(Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|per.PEleMax|per.PEleMin|assPow.PEleDem|assPow.assMesP.u|assPow.assMesDP.u",fileNamePrefix="Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001451/0.001451, allocations: 115 kB / 16.48 MB, free: 6.441 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001369/0.001369, allocations: 191.3 kB / 17.42 MB, free: 5.652 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.325/1.325, allocations: 225.6 MB / 243.8 MB, free: 14.1 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo): time 2.526/2.526, allocations: 476.7 MB / 0.7552 GB, free: 11.5 MB / 0.6231 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.561e-05/2.561e-05, allocations: 9.453 kB / 1.097 GB, free: 11.75 MB / 0.8419 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower): time 0.00432/0.004345, allocations: 2.444 MB / 1.099 GB, free: 10.04 MB / 0.8419 GB
Notification: Performance of NFInst.instExpressions: time 0.003342/0.007688, allocations: 1.52 MB / 1.1 GB, free: 8.973 MB / 0.8419 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003919/0.00808, allocations: 8.812 kB / 1.1 GB, free: 8.969 MB / 0.8419 GB
Notification: Performance of NFTyping.typeComponents: time 0.0008483/0.008928, allocations: 218.9 kB / 1.101 GB, free: 8.883 MB / 0.8419 GB
Notification: Performance of NFTyping.typeBindings: time 0.0004879/0.009416, allocations: 161.4 kB / 1.101 GB, free: 8.797 MB / 0.8419 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0005949/0.01001, allocations: 191.7 kB / 1.101 GB, free: 8.691 MB / 0.8419 GB
Notification: Performance of NFFlatten.flatten: time 0.0005915/0.0106, allocations: 401.1 kB / 1.101 GB, free: 8.496 MB / 0.8419 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0001606/0.01076, allocations: 55.03 kB / 1.101 GB, free: 8.465 MB / 0.8419 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0002359/0.011, allocations: 143.4 kB / 1.102 GB, free: 8.398 MB / 0.8419 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00021/0.01121, allocations: 153.1 kB / 1.102 GB, free: 8.328 MB / 0.8419 GB
Notification: Performance of NFPackage.collectConstants: time 4.918e-05/0.01126, allocations: 21.62 kB / 1.102 GB, free: 8.328 MB / 0.8419 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0002873/0.01155, allocations: 126.3 kB / 1.102 GB, free: 8.297 MB / 0.8419 GB
Notification: Performance of combineBinaries: time 0.000418/0.01196, allocations: 471.6 kB / 1.102 GB, free: 7.969 MB / 0.8419 GB
Notification: Performance of replaceArrayConstructors: time 0.0002508/0.01221, allocations: 322.7 kB / 1.103 GB, free: 7.734 MB / 0.8419 GB
Notification: Performance of NFVerifyModel.verify: time 5.88e-05/0.01227, allocations: 41.38 kB / 1.103 GB, free: 7.711 MB / 0.8419 GB
Notification: Performance of FrontEnd: time 5.873e-05/0.01233, allocations: 5.625 kB / 1.103 GB, free: 7.711 MB / 0.8419 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 28 (28)
 * Number of variables: 28 (28)
Notification: Performance of Bindings: time 0.001426/0.01376, allocations: 1.258 MB / 1.104 GB, free: 6.723 MB / 0.8419 GB
Notification: Performance of FunctionAlias: time 0.0001369/0.01389, allocations: 88.08 kB / 1.104 GB, free: 6.668 MB / 0.8419 GB
Notification: Performance of Early Inline: time 0.0004764/0.01437, allocations: 389.5 kB / 1.104 GB, free: 6.406 MB / 0.8419 GB
Notification: Performance of Simplify 1: time 0.0001267/0.0145, allocations: 96.86 kB / 1.104 GB, free: 6.324 MB / 0.8419 GB
Notification: Performance of Alias: time 0.001021/0.01552, allocations: 0.6687 MB / 1.105 GB, free: 5.855 MB / 0.8419 GB
Notification: Performance of Simplify 2: time 9.603e-05/0.01561, allocations: 74.3 kB / 1.105 GB, free: 5.785 MB / 0.8419 GB
Notification: Performance of Remove Stream: time 0.0001111/0.01572, allocations: 75.69 kB / 1.105 GB, free: 5.707 MB / 0.8419 GB
Notification: Performance of Detect States: time 0.0002922/0.01602, allocations: 180.2 kB / 1.105 GB, free: 5.551 MB / 0.8419 GB
Notification: Performance of Events: time 0.0001143/0.01613, allocations: 63.67 kB / 1.105 GB, free: 5.516 MB / 0.8419 GB
Notification: Performance of Partitioning: time 0.0001588/0.01629, allocations: 114.3 kB / 1.106 GB, free: 5.445 MB / 0.8419 GB
Notification: Performance of Causalize: time 0.0004349/0.01673, allocations: 327.5 kB / 1.106 GB, free: 5.34 MB / 0.8419 GB
Notification: Performance of After Index Reduction Inline: time 0.0002731/0.017, allocations: 211.8 kB / 1.106 GB, free: 5.223 MB / 0.8419 GB
Notification: Performance of Simplify: time 0.001993/0.01899, allocations: 447.7 kB / 1.107 GB, free: 4.934 MB / 0.8419 GB
Notification: Performance of Inline: time 0.0004889/0.01948, allocations: 394.8 kB / 1.107 GB, free: 4.699 MB / 0.8419 GB
Notification: Performance of Partitioning: time 4.108e-05/0.01952, allocations: 31.23 kB / 1.107 GB, free: 4.668 MB / 0.8419 GB
Notification: Performance of Cleanup: time 9.622e-05/0.01962, allocations: 87.12 kB / 1.107 GB, free: 4.617 MB / 0.8419 GB
Notification: Performance of Causalize: time 0.001354/0.02097, allocations: 0.9765 MB / 1.108 GB, free: 4.336 MB / 0.8419 GB
Notification: Performance of Tearing: time 1.049e-05/0.02098, allocations: 1.438 kB / 1.108 GB, free: 4.336 MB / 0.8419 GB
Notification: Performance of Initialization: time 4.51e-07/0.02098, allocations: 0 / 1.108 GB, free: 4.336 MB / 0.8419 GB
Notification: Performance of Tearing: time 3.757e-06/0.02099, allocations: 5.375 kB / 1.108 GB, free: 4.332 MB / 0.8419 GB
Notification: Performance of Categorize: time 8.096e-06/0.02099, allocations: 2.078 kB / 1.108 GB, free: 4.332 MB / 0.8419 GB
Notification: Performance of Solve: time 0.0002007/0.0212, allocations: 95.95 kB / 1.108 GB, free: 4.309 MB / 0.8419 GB
Notification: Performance of Jacobian: time 0.0002391/0.02143, allocations: 260.5 kB / 1.108 GB, free: 4.066 MB / 0.8419 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 0
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 1 (1) {assPow.demRat.x}
 * Number of discrete states: .................... 2 (2) {PEleDem.tab.nextTimeEvent, PEleDem.tab.nextTimeEventScaled}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 10 (10) {assPow.nor.y, assPow.not2.u, assPow.maxPow.y, assPow.minPow.y, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_0}
 * Number of clocks: ............................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 16 (scalar:16, array:0, record:0)
 * Number of multi strong components: ............ 2 (algorithm:0, when:2, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 40 (scalar:38, array:1, record:1)
 * Number of multi strong components: ............ 2 (algorithm:2, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 5.09e-05/0.02149, allocations: 38.28 kB / 1.108 GB, free: 4.043 MB / 0.8419 GB
Notification: Performance of SimCode: time 0.003858/0.02534, allocations: 2.705 MB / 1.111 GB, free: 2.523 MB / 0.8419 GB
Notification: Performance of Templates: time 0.007868/0.03321, allocations: 3.074 MB / 1.114 GB, free: 2.223 MB / 0.8419 GB
make -j1 -f Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower.makefile
(rm -f Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower.pipe ; mkfifo Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower.pipe ; head -c 1048576 < Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower.pipe >> ../files/Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower.sim & ./Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower  -abortSlowSimulation -alarm=300  -emit_protected -lv LOG_STATS > Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower.pipe 2>&1)
diffSimulationResults("Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_Fluid_CHPs_BaseClasses_Validation_AssertPower.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_11_Buildings.Fluid.CHPs.BaseClasses.Validation.AssertPower.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
""

Variables in the reference:time,per.PEleMax,per.PEleMin,assPow.PEleDem,assPow.assMesP.u,assPow.assMesDP.u

Variables in the result:PEleDem.extrapolation,PEleDem.nT,PEleDem.nout,PEleDem.offset[1],PEleDem.smoothness,PEleDem.t0,PEleDem.tab.columns[1],PEleDem.tab.extrapolation,PEleDem.tab.nout,PEleDem.tab.offset[1],PEleDem.tab.p_offset[1],PEleDem.tab.shiftTime,PEleDem.tab.smoothness,PEleDem.tab.startTime,PEleDem.tab.t_max,PEleDem.tab.t_maxScaled,PEleDem.tab.t_min,PEleDem.tab.t_minScaled,PEleDem.tab.tableOnFile,PEleDem.tab.table[1,1],PEleDem.tab.table[1,2],PEleDem.tab.table[2,1],PEleDem.tab.table[2,2],PEleDem.tab.table[3,1],PEleDem.tab.table[3,2],PEleDem.tab.table[4,1],PEleDem.tab.table[4,2],PEleDem.tab.table[5,1],PEleDem.tab.table[5,2],PEleDem.tab.table[6,1],PEleDem.tab.table[6,2],PEleDem.tab.table[7,1],PEleDem.tab.table[7,2],PEleDem.tab.timeEvents,PEleDem.tab.timeScale,PEleDem.tab.timeScaled,PEleDem.tab.verboseExtrapolation,PEleDem.tab.verboseRead,PEleDem.table[1,1],PEleDem.table[1,2],PEleDem.table[2,1],PEleDem.table[2,2],PEleDem.table[3,1],PEleDem.table[3,2],PEleDem.table[4,1],PEleDem.table[4,2],PEleDem.table[5,1],PEleDem.table[5,2],PEleDem.table[6,1],PEleDem.table[6,2],PEleDem.table[7,1],PEleDem.table[7,2],PEleDem.timeRange,PEleDem.timeScale,assPow.PEleDem,assPow.PEleMax,assPow.PEleMin,assPow.assMesDP.u,assPow.assMesP.u,assPow.dPEleMax,assPow.demRat.T,assPow.demRat.initType,assPow.demRat.k,assPow.demRat.x_start,assPow.demRat.y_start,assPow.demRat.zeroGain,assPow.maxPow.pre_y_start,assPow.maxPow.uHigh,assPow.maxPow.uLow,assPow.maxRat.greNoHys.t,assPow.maxRat.h,assPow.maxRat.have_hysteresis,assPow.maxRat.pre_y_start,assPow.maxRat.t,assPow.minPow.pre_y_start,assPow.minPow.uHigh,assPow.minPow.uLow,assPow.nor.y,assPow.not2.u,assPow.use_powerRateLimit,per.LHVFue,per.PCooDow,per.PEleMax,per.PEleMin,per.PStaBy,per.TEngNom,per.TWatMax,per.UAHex,per.UALos,per.capEng,per.capHeaRec,per.coeEtaE[10],per.coeEtaE[11],per.coeEtaE[12],per.coeEtaE[13],per.coeEtaE[14],per.coeEtaE[15],per.coeEtaE[16],per.coeEtaE[17],per.coeEtaE[18],per.coeEtaE[19],per.coeEtaE[1],per.coeEtaE[20],per.coeEtaE[21],per.coeEtaE[22],per.coeEtaE[23],per.coeEtaE[24],per.coeEtaE[25],per.coeEtaE[26],per.coeEtaE[27],per.coeEtaE[2],per.coeEtaE[3],per.coeEtaE[4],per.coeEtaE[5],per.coeEtaE[6],per.coeEtaE[7],per.coeEtaE[8],per.coeEtaE[9],per.coeEtaQ[10],per.coeEtaQ[11],per.coeEtaQ[12],per.coeEtaQ[13],per.coeEtaQ[14],per.coeEtaQ[15],per.coeEtaQ[16],per.coeEtaQ[17],per.coeEtaQ[18],per.coeEtaQ[19],per.coeEtaQ[1],per.coeEtaQ[20],per.coeEtaQ[21],per.coeEtaQ[22],per.coeEtaQ[23],per.coeEtaQ[24],per.coeEtaQ[25],per.coeEtaQ[26],per.coeEtaQ[27],per.coeEtaQ[2],per.coeEtaQ[3],per.coeEtaQ[4],per.coeEtaQ[5],per.coeEtaQ[6],per.coeEtaQ[7],per.coeEtaQ[8],per.coeEtaQ[9],per.coeMasAir[1],per.coeMasAir[2],per.coeMasAir[3],per.coeMasWat[1],per.coeMasWat[2],per.coeMasWat[3],per.coeMasWat[4],per.coeMasWat[5],per.coeMasWat[6],per.compute_coolingWaterFlowRate,per.coolDownOptional,per.dPEleMax,per.dmFueMax_flow,per.kF,per.kP,per.mWatMin_flow,per.rFue,per.timeDelayCool,per.timeDelayStart,per.use_fuelRateLimit,per.use_powerRateLimit,per.warmUpByTimeDelay,time