Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "[:1:22-1:33:writable] Warning: Modelica only supports 32-bit signed integers! Transforming: 13743895347 into a real [:1:1-1:33:writable] Error: Class GC_set_max_heap_size not found in scope (looking for a function or record). Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.000438/0.000438, allocations: 0 / 0, free: 0 / 0 " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.0003864/0.0003864, allocations: 0 / 0, free: 0 / 0 " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.3391/0.3391, allocations: 0 / 0, free: 0 / 0 " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 0.8104/0.8104, allocations: 0 / 0, free: 0 / 0 " [Timeout remaining time 179] Using package Buildings with version 14.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo) Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: "" <> buildModelFMU(Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime,fileNamePrefix="Buildings_latest_Buildings_Controls_OBC_Utilities_Validation_OptimalStartCoolingPositiveStartTime",fmuType="me_cs",version="3.0",platforms={"wasm"}) "" <> buildModelFMU(Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime,fileNamePrefix="Buildings_latest_Buildings_Controls_OBC_Utilities_Validation_OptimalStartCoolingPositiveStartTime",fmuType="me_cs",version="3.0",platforms={"wasm"}) [Timeout 300] "Notification: Performance of FrontEnd - loaded program: time 4.478e-06/4.478e-06, allocations: 0 / 0, free: 0 / 0 Notification: Performance of FrontEnd - Absyn->SCode: time 1.864e-05/2.311e-05, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime): time 0.01167/0.0117, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFInst.instExpressions: time 0.01001/0.02171, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFInst.updateImplicitVariability: time 0.00203/0.02374, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFTyping.typeComponents: time 0.0009905/0.02473, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFTyping.typeBindings: time 0.001272/0.026, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFTyping.typeClassSections: time 0.00283/0.02883, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFFlatten.flatten: time 0.002143/0.03097, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFFlatten.resolveConnections: time 0.001575/0.03255, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFEvalConstants.evaluate: time 0.002115/0.03466, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFSimplifyModel.simplify: time 0.0009618/0.03562, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFPackage.collectConstants: time 0.0002728/0.0359, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFFlatten.collectFunctions: time 0.0007796/0.03668, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFScalarize.scalarize: time 0.0004385/0.03711, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFVerifyModel.verify: time 0.0007512/0.03787, allocations: 0 / 0, free: 0 / 0 Notification: Performance of NFConvertDAE.convert: time 0.003452/0.04132, allocations: 0 / 0, free: 0 / 0 Notification: Performance of FrontEnd - DAE generated: time 0.0001503/0.04147, allocations: 0 / 0, free: 0 / 0 Notification: Performance of FrontEnd: time 5.801e-06/0.04147, allocations: 0 / 0, free: 0 / 0 Notification: Performance of Transformations before backend: time 1.924e-05/0.04149, allocations: 0 / 0, free: 0 / 0 Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 196 * Number of variables: 196 Notification: Performance of Generate backend data structure: time 0.006383/0.04788, allocations: 0 / 0, free: 0 / 0 Notification: Performance of prepare preOptimizeDAE: time 0.0001102/0.04799, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0008484/0.04883, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001322/0.05016, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt evaluateParameters (simulation): time 0.003127/0.05328, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001888/0.05347, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004459/0.05392, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt clockPartitioning (simulation): time 0.005489/0.05941, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt findStateOrder (simulation): time 8.942e-05/0.0595, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003181/0.05982, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.083e-05/0.05986, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003987/0.06384, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.01258/0.07642, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt comSubExp (simulation): time 0.004698/0.08112, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt resolveLoops (simulation): time 0.001771/0.08289, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt evalFunc (simulation): time 0.000119/0.08301, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.00269/0.0857, allocations: 0 / 0, free: 0 / 0 Notification: Performance of pre-optimization done (n=88): time 0.0001648/0.08586, allocations: 0 / 0, free: 0 / 0 Notification: Performance of matching and sorting (n=88): time 0.007089/0.09295, allocations: 0 / 0, free: 0 / 0 Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001796/0.09313, allocations: 0 / 0, free: 0 / 0 Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001902/0.09504, allocations: 0 / 0, free: 0 / 0 Notification: Performance of collectPreVariables (initialization): time 0.0005404/0.09558, allocations: 0 / 0, free: 0 / 0 Notification: Performance of collectInitialEqns (initialization): time 0.0006411/0.09622, allocations: 0 / 0, free: 0 / 0 Notification: Performance of collectInitialBindings (initialization): time 0.0005249/0.09674, allocations: 0 / 0, free: 0 / 0 Notification: Performance of simplifyInitialFunctions (initialization): time 0.001313/0.09806, allocations: 0 / 0, free: 0 / 0 Notification: Performance of setup shared object (initialization): time 0.0004538/0.09851, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preBalanceInitialSystem (initialization): time 0.001888/0.1004, allocations: 0 / 0, free: 0 / 0 Notification: Performance of partitionIndependentBlocks (initialization): time 0.002384/0.1028, allocations: 0 / 0, free: 0 / 0 Notification: Performance of analyzeInitialSystem (initialization): time 0.003638/0.1064, allocations: 0 / 0, free: 0 / 0 Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.104e-05/0.1064, allocations: 0 / 0, free: 0 / 0 Notification: Performance of matching and sorting (n=132) (initialization): time 0.005805/0.1122, allocations: 0 / 0, free: 0 / 0 Notification: Performance of prepare postOptimizeDAE: time 7.164e-05/0.1123, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.753e-05/0.1124, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt tearingSystem (initialization): time 4.005e-05/0.1124, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001134/0.1135, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.099e-05/0.1136, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009805/0.1146, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002701/0.1148, allocations: 0 / 0, free: 0 / 0 Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002654/0.1175, allocations: 0 / 0, free: 0 / 0 Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002254/0.1197, allocations: 0 / 0, free: 0 / 0 Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003333/0.1231, allocations: 0 / 0, free: 0 / 0 Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.102e-05/0.1231, allocations: 0 / 0, free: 0 / 0 Notification: Performance of matching and sorting (n=132) (initialization_lambda0): time 0.005505/0.1286, allocations: 0 / 0, free: 0 / 0 Notification: Performance of prepare postOptimizeDAE: time 4.902e-05/0.1287, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.03e-05/0.1287, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt tearingSystem (initialization): time 3.486e-05/0.1287, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001057/0.1298, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.731e-05/0.1298, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009755/0.1308, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002462/0.131, allocations: 0 / 0, free: 0 / 0 Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 15 * Number of states: 0 () * Number of discrete variables: 86 (optStaCoo.optCoo.tim.passed,$PRE.optStaCoo.optCoo.tim.passed,optStaCoo.optCoo.edg.u,$PRE.optStaCoo.optCoo.edg.u,optStaCoo.optCoo.edg.y,optStaCoo.optCoo.falEdg.y,optStaCoo.optCoo.falEdg.not_u,$PRE.optStaCoo.optCoo.falEdg.not_u,optStaCoo.optCoo.hys.y,$PRE.optStaCoo.optCoo.hys.y,optStaCoo.optCoo.hysOpt.y,$PRE.optStaCoo.optCoo.hysOpt.y,optStaCoo.optCoo.truHol.u,$PRE.optStaCoo.optCoo.truHol.u,optStaCoo.optCoo.truHol.y,$PRE.optStaCoo.optCoo.truHol.y,optStaCoo.optCoo.truHol.not_u,$PRE.optStaCoo.optCoo.truHol.not_u,optStaCoo.optCoo.truHol.not_y,$PRE.optStaCoo.optCoo.truHol.not_y,optStaCoo.optCoo.truHol.entryTimeTrue,$PRE.optStaCoo.optCoo.truHol.entryTimeTrue,optStaCoo.optCoo.truHol.entryTimeFalse,$PRE.optStaCoo.optCoo.truHol.entryTimeFalse,optStaCoo.optCoo.pre.u,$PRE.optStaCoo.optCoo.pre.u,optStaCoo.optCoo.lat.u,optStaCoo.optCoo.lat.clr,optStaCoo.optCoo.lat.y,$PRE.optStaCoo.optCoo.lat.y,optStaCoo.optCoo.tim.entryTime,$PRE.optStaCoo.optCoo.tim.entryTime,optStaCoo.optCoo.samTimOpt.y,$PRE.optStaCoo.optCoo.samTimOpt.y,optStaCoo.optCoo.greThr.y,optStaCoo.hysSta.greHys.y,$PRE.optStaCoo.hysSta.greHys.y,optStaCoo.falEdg.not_u,$PRE.optStaCoo.falEdg.not_u,occSch.occupied,$PRE.occSch.occupied,occSch.tOcc,$PRE.occSch.tOcc,occSch.tNonOcc,$PRE.occSch.tNonOcc,occSch.tNext,$PRE.occSch.tNext,$whenCondition1,$whenCondition2,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,optStaCoo.optCoo.samTemSloAve.y,optStaCoo.optCoo.samTemSloAve.iSample,$PRE.optStaCoo.optCoo.samTemSloAve.iSample,optStaCoo.optCoo.samTemSloAve.counter,$PRE.optStaCoo.optCoo.samTemSloAve.counter,optStaCoo.optCoo.samTemSloAve.index,optStaCoo.optCoo.samTemSloAve.ySample[1],$PRE.optStaCoo.optCoo.samTemSloAve.ySample[1],optStaCoo.optCoo.samTemSloAve.ySample[2],$PRE.optStaCoo.optCoo.samTemSloAve.ySample[2],optStaCoo.optCoo.samTemSloAve.ySample[3],$PRE.optStaCoo.optCoo.samTemSloAve.ySample[3],optStaCoo.optCoo.dTCalOn.y,$PRE.optStaCoo.optCoo.dTCalOn.y,optStaCoo.optCoo.dTHVACOn.y,$PRE.optStaCoo.optCoo.dTHVACOn.y,optStaCoo.optCoo.triSam.y,$PRE.optStaCoo.optCoo.triSam.y,optStaCoo.optCoo.triSam1.y,$PRE.optStaCoo.optCoo.triSam1.y,optStaCoo.optCoo.reqStaUp.y,optStaCoo.optCoo.triAve.u2,optStaCoo.optCoo.triAve.y,$whenCondition13,conPID.con1.y,optStaCoo.con.y,TRoo.local_reset) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (127): * Single equations (assignments): 125 * Array equations: 1 * Algorithm blocks: 0 * Record equations: 1 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of prepare postOptimizeDAE: time 0.001353/0.1324, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006093/0.133, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00556/0.1386, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.79e-05/0.1386, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt constantLinearSystem (simulation): time 2.035e-05/0.1386, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.844e-05/0.1387, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00944/0.1481, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.37e-05/0.1481, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000653/0.1488, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt tearingSystem (simulation): time 2.104e-05/0.1488, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002773/0.1491, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.583e-05/0.1491, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.358e-06/0.1491, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt symbolicJacobian (simulation): time 0.007249/0.1563, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt removeConstants (simulation): time 0.001379/0.1577, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005604/0.1583, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007679/0.159, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008279/0.1599, allocations: 0 / 0, free: 0 / 0 Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002598/0.1601, allocations: 0 / 0, free: 0 / 0 Notification: Performance of sorting global known variables: time 0.001266/0.1614, allocations: 0 / 0, free: 0 / 0 Notification: Performance of sort global known variables: time 2.125e-05/0.1614, allocations: 0 / 0, free: 0 / 0 Notification: Performance of remove unused functions: time 0.004073/0.1655, allocations: 0 / 0, free: 0 / 0 Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 1 * Number of states: 2 (conPID.I.y,TRoo.y) * Number of discrete variables: 53 (optStaCoo.optCoo.triAve.y,optStaCoo.optCoo.edg.y,optStaCoo.optCoo.falEdg.y,optStaCoo.optCoo.lat.clr,optStaCoo.optCoo.lat.u,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition2,$whenCondition1,occSch.tNext,occSch.tNonOcc,occSch.tOcc,occSch.occupied,optStaCoo.falEdg.not_u,optStaCoo.hysSta.greHys.y,optStaCoo.optCoo.triAve.u2,optStaCoo.optCoo.reqStaUp.y,optStaCoo.optCoo.greThr.y,optStaCoo.optCoo.samTimOpt.y,optStaCoo.optCoo.tim.entryTime,optStaCoo.optCoo.tim.passed,optStaCoo.optCoo.lat.y,optStaCoo.optCoo.triSam1.y,optStaCoo.optCoo.triSam.y,optStaCoo.optCoo.pre.u,optStaCoo.optCoo.truHol.entryTimeFalse,optStaCoo.optCoo.truHol.entryTimeTrue,optStaCoo.optCoo.truHol.not_y,optStaCoo.optCoo.truHol.not_u,optStaCoo.optCoo.truHol.y,optStaCoo.optCoo.truHol.u,optStaCoo.optCoo.hysOpt.y,optStaCoo.optCoo.hys.y,optStaCoo.optCoo.falEdg.not_u,optStaCoo.optCoo.edg.u,optStaCoo.optCoo.dTHVACOn.y,optStaCoo.optCoo.dTCalOn.y,optStaCoo.optCoo.samTemSloAve.ySample[3],optStaCoo.optCoo.samTemSloAve.ySample[2],optStaCoo.optCoo.samTemSloAve.ySample[1],optStaCoo.optCoo.samTemSloAve.index,optStaCoo.optCoo.samTemSloAve.counter,optStaCoo.optCoo.samTemSloAve.iSample,optStaCoo.optCoo.samTemSloAve.y) * Number of discrete states: 20 (optStaCoo.optCoo.truHol.entryTimeFalse,optStaCoo.optCoo.truHol.entryTimeTrue,occSch.tNext,optStaCoo.hysSta.greHys.y,optStaCoo.falEdg.not_u,optStaCoo.optCoo.truHol.u,optStaCoo.optCoo.truHol.not_u,optStaCoo.optCoo.truHol.y,optStaCoo.optCoo.truHol.not_y,optStaCoo.optCoo.tim.entryTime,optStaCoo.optCoo.pre.u,optStaCoo.optCoo.hys.y,optStaCoo.optCoo.falEdg.not_u,optStaCoo.optCoo.edg.u,optStaCoo.optCoo.samTemSloAve.iSample,optStaCoo.optCoo.samTemSloAve.ySample[1],optStaCoo.optCoo.samTemSloAve.ySample[2],optStaCoo.optCoo.samTemSloAve.ySample[3],optStaCoo.optCoo.samTemSloAve.counter,optStaCoo.optCoo.hysOpt.y) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (83): * Single equations (assignments): 66 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 17 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of Backend phase and start with SimCode phase: time 0.009762/0.1752, allocations: 0 / 0, free: 0 / 0 Notification: Performance of simCode: created initialization part: time 0.006678/0.1819, allocations: 0 / 0, free: 0 / 0 Notification: Performance of simCode: created event and clocks part: time 9.137e-06/0.1819, allocations: 0 / 0, free: 0 / 0 Notification: Performance of simCode: created simulation system equations: time 0.002008/0.1839, allocations: 0 / 0, free: 0 / 0 Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002957/0.1869, allocations: 0 / 0, free: 0 / 0 Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03092/0.2178, allocations: 0 / 0, free: 0 / 0 Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00137/0.2192, allocations: 0 / 0, free: 0 / 0 Notification: Performance of simCode: alias equations: time 0.001498/0.2207, allocations: 0 / 0, free: 0 / 0 Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002311/0.223, allocations: 0 / 0, free: 0 / 0 Notification: Performance of SimCode: time 0.001049/0.2241, allocations: 0 / 0, free: 0 / 0 Notification: Performance of FMU modelDescription.xml: time 0.006777/0.2308, allocations: 0 / 0, free: 0 / 0 Notification: Performance of FMU model kernel: time 0.005344/0.2362, allocations: 0 / 0, free: 0 / 0 Notification: Performance of FMU translated model: time 0.02949/0.2657, allocations: 0 / 0, free: 0 / 0 Notification: Performance of FMU component link: time 1.199e-05/0.2657, allocations: 0 / 0, free: 0 / 0 Notification: Performance of FMU precompile: time 1.568e-05/0.2657, allocations: 0 / 0, free: 0 / 0 Notification: Performance of FMU write (0.1 MB unzipped): time 0.000204/0.2659, allocations: 0 / 0, free: 0 / 0 Notification: Building FMU for platform 'wasm' (1/1). Notification: Finished FMU for platform 'wasm' (1/1). " [Timeout remaining time 300] simulate(Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime,startTime=34000,stopTime=864000,tolerance=1e-07,numberOfIntervals=2500,outputFormat="mat",variableFilter="time|optStaCoo.tOpt|TSetCoo.y|optStaCoo.TZon|optStaCoo.optOn",fileNamePrefix="Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime",simflags=" -alarm=240 -emit_protected -lv LOG_STATS -startTime=34000 -stopTime=864000 -tolerance=1e-07 -stepSize=332 -r=Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_res.mat",resimulateExecutable="Buildings_latest_Buildings_Controls_OBC_Utilities_Validation_OptimalStartCoolingPositiveStartTime.fmu") [Timeout 240] "" [Timeout remaining time 240] diffSimulationResults("Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Controls_OBC_Utilities_Validation_OptimalStartCoolingPositiveStartTime.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300] "" [Timeout remaining time 300] Reference file matches simulate(Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime,startTime=34000,stopTime=864000,tolerance=1e-07,numberOfIntervals=2500,outputFormat="mat",variableFilter="time|optStaCoo.tOpt|TSetCoo.y|optStaCoo.TZon|optStaCoo.optOn",fileNamePrefix="Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime",simflags=" -alarm=240 -emit_protected -lv LOG_STATS -startTime=34000 -stopTime=864000 -tolerance=1e-07 -stepSize=332 -r=Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_me_res.mat -s fmi3:me:daskr",resimulateExecutable="Buildings_latest_Buildings_Controls_OBC_Utilities_Validation_OptimalStartCoolingPositiveStartTime.fmu") [Timeout 240] "" [Timeout remaining time 240] diffSimulationResults("Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_me_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Controls_OBC_Utilities_Validation_OptimalStartCoolingPositiveStartTime.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_me.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300] "Error: Could not read variable optStaCoo.optOn in file Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_me_res.mat. Warning: Get data of variable optStaCoo.optOn from file Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_me_res.mat failed! " [Timeout remaining time 300] "" Variables in the reference:time,optStaCoo.tOpt,TSetCoo.y,optStaCoo.TZon,optStaCoo.optOn Variables in the result:QCoo.k,QCoo.u,QCoo.y,TOut.amplitude,TOut.freqHz,TOut.offset,TOut.phase,TOut.startTime,TOut.y,TRoo.initType,TRoo.k,TRoo.u,TRoo.use_reset,TRoo.use_set,TRoo.y,TRoo.y_start,TSetCoo.realFalse,TSetCoo.realTrue,TSetCoo.u,TSetCoo.y,TSetCooOcc.k,TSetCooOcc.y,UA.k,UA.u,UA.y,__zc_0,__zc_1,__zc_2,__zc_3,__zc_4,__zc_5,__zc_6,__zc_7,add.u1,add.u2,add.y,booToRea.realFalse,booToRea.realTrue,booToRea.y,conPID.I.k,conPID.I.u,conPID.I.y,conPID.I.y_start,conPID.Nd,conPID.Ni,conPID.P.k,conPID.P.u,conPID.P.y,conPID.Td,conPID.Ti,conPID.controlError.u1,conPID.controlError.u2,conPID.controlError.y,conPID.controllerType,conPID.errI1.u1,conPID.errI1.u2,conPID.errI1.y,conPID.errI2.u1,conPID.errI2.u2,conPID.errI2.y,conPID.errP.u1,conPID.errP.u2,conPID.errP.y,conPID.k,conPID.lim.u,conPID.lim.uMax,conPID.lim.uMin,conPID.lim.y,conPID.r,conPID.reverseActing,conPID.u_m,conPID.u_s,conPID.xi_start,conPID.y,conPID.yMax,conPID.yMin,conPID.yd_start,dT.u1,dT.u2,dT.y,dTdt.u1,dTdt.u2,dTdt.y,der(TRoo.y),der(conPID.I.y),occSch.firstEntryOccupied,occSch.occupancy[1],occSch.occupancy[2],occSch.occupied,occSch.period,occSch.tNexNonOcc,occSch.tNexOcc,optStaCoo.TSetZonCoo,optStaCoo.TZon,optStaCoo.computeCooling,optStaCoo.computeHeating,optStaCoo.hysSta.h,optStaCoo.hysSta.pre_y_start,optStaCoo.hysSta.t,optStaCoo.hysSta.u,optStaCoo.hysSta.y,optStaCoo.nDay,optStaCoo.optCoo.TDif,optStaCoo.optCoo.nDay,optStaCoo.optCoo.staCal,optStaCoo.optCoo.tNexOcc,optStaCoo.optCoo.tOpt,optStaCoo.optCoo.tOptMax,optStaCoo.optCoo.thrOptOn,optStaCoo.optCoo.uHigh,optStaCoo.optCoo.uLow,optStaCoo.tNexOcc,optStaCoo.tOpt,optStaCoo.tOptMax,optStaCoo.thrOptOn,optStaCoo.uHigh,optStaCoo.uLow,time simulate(Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime,startTime=34000,stopTime=864000,tolerance=1e-07,numberOfIntervals=2500,outputFormat="mat",variableFilter="time|optStaCoo.tOpt|TSetCoo.y|optStaCoo.TZon|optStaCoo.optOn",fileNamePrefix="Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime",simflags=" -alarm=240 -emit_protected -lv LOG_STATS -startTime=34000 -stopTime=864000 -tolerance=1e-07 -stepSize=332 -r=Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_cs_res.mat -s fmi3:cs",resimulateExecutable="Buildings_latest_Buildings_Controls_OBC_Utilities_Validation_OptimalStartCoolingPositiveStartTime.fmu") [Timeout 240] "" [Timeout remaining time 240] diffSimulationResults("Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_cs_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Controls_OBC_Utilities_Validation_OptimalStartCoolingPositiveStartTime.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_cs.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300] "Error: Could not read variable optStaCoo.optOn in file Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_cs_res.mat. Warning: Get data of variable optStaCoo.optOn from file Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartCoolingPositiveStartTime_cs_res.mat failed! " [Timeout remaining time 300] Reference file matches [Calling sys.exit(0), Time elapsed: 3.0891514640534297]