Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001398/0.001398, allocations: 109.7 kB / 17.54 MB, free: 4.641 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00138/0.00138, allocations: 190.6 kB / 20.71 MB, free: 1.484 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.274/1.274, allocations: 225.6 MB / 249.3 MB, free: 3.352 MB / 190.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo): time 2.305/2.305, allocations: 443.5 MB / 0.7304 GB, free: 13.95 MB / 0.5762 GB
"
[Timeout remaining time 177]
Using package Buildings with version 10.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.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: "" <> buildModelFMU(Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE,fileNamePrefix="Buildings_10_Buildings_Experimental_DHC_Loads_BaseClasses_Validation_SimpleRoomODE",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE,fileNamePrefix="Buildings_10_Buildings_Experimental_DHC_Loads_BaseClasses_Validation_SimpleRoomODE",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.001789/0.001789, allocations: 67.89 kB / 1.059 GB, free: 0.957 MB / 0.795 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2482/0.25, allocations: 160.7 MB / 1.216 GB, free: 15.93 MB / 0.9669 GB
Notification: Performance of NFInst.instantiate(Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE): time 0.7947/1.045, allocations: 319.8 MB / 1.528 GB, free: 12 kB / 1.186 GB
Notification: Performance of NFInst.instExpressions: time 0.05908/1.104, allocations: 38.08 MB / 1.565 GB, free: 9.848 MB / 1.232 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01108/1.115, allocations: 286.6 kB / 1.565 GB, free: 9.566 MB / 1.232 GB
Notification: Performance of NFTyping.typeComponents: time 0.007993/1.123, allocations: 2.866 MB / 1.568 GB, free: 6.68 MB / 1.232 GB
Notification: Performance of NFTyping.typeBindings: time 0.02076/1.144, allocations: 6.875 MB / 1.575 GB, free: 15.78 MB / 1.248 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01459/1.158, allocations: 6.295 MB / 1.581 GB, free: 9.508 MB / 1.248 GB
Notification: Performance of NFFlatten.flatten: time 0.04254/1.201, allocations: 39.83 MB / 1.62 GB, free: 1.551 MB / 1.279 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03331/1.234, allocations: 24.9 MB / 1.644 GB, free: 8.465 MB / 1.311 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02457/1.259, allocations: 16.57 MB / 1.66 GB, free: 7.852 MB / 1.326 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02859/1.287, allocations: 19.06 MB / 1.679 GB, free: 4.742 MB / 1.342 GB
Notification: Performance of NFPackage.collectConstants: time 0.0113/1.299, allocations: 4.863 MB / 1.684 GB, free: 15.88 MB / 1.357 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01797/1.316, allocations: 7.962 MB / 1.692 GB, free: 7.91 MB / 1.357 GB
Notification: Performance of NFScalarize.scalarize: time 0.01462/1.331, allocations: 10.39 MB / 1.702 GB, free: 13.5 MB / 1.373 GB
Notification: Performance of NFVerifyModel.verify: time 0.02851/1.36, allocations: 18.05 MB / 1.719 GB, free: 11.38 MB / 1.389 GB
Notification: Performance of NFConvertDAE.convert: time 0.06904/1.429, allocations: 63.17 MB / 1.781 GB, free: 12 MB / 1.451 GB
Notification: Performance of FrontEnd - DAE generated: time 6.703e-06/1.429, allocations: 0 / 1.781 GB, free: 12 MB / 1.451 GB
Notification: Performance of FrontEnd: time 2.104e-06/1.429, allocations: 0 / 1.781 GB, free: 12 MB / 1.451 GB
Notification: Performance of Transformations before backend: time 0.001397/1.43, allocations: 4 kB / 1.781 GB, free: 12 MB / 1.451 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 6908
 * Number of variables: 6908
Notification: Performance of Generate backend data structure: time 0.09526/1.525, allocations: 35.94 MB / 1.816 GB, free: 7.742 MB / 1.482 GB
Notification: Performance of prepare preOptimizeDAE: time 4.517e-05/1.525, allocations: 12.02 kB / 1.816 GB, free: 7.73 MB / 1.482 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.01123/1.537, allocations: 3.551 MB / 1.82 GB, free: 4.168 MB / 1.482 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 1.096/2.633, allocations: 31.58 MB / 1.85 GB, free: 466.7 MB / 1.483 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03242/2.665, allocations: 17.02 MB / 1.867 GB, free: 460.9 MB / 1.483 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001593/2.667, allocations: 1.976 MB / 1.869 GB, free: 460 MB / 1.483 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01065/2.677, allocations: 2.557 MB / 1.871 GB, free: 459.1 MB / 1.483 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.1249/2.802, allocations: 53.38 MB / 1.924 GB, free: 426.9 MB / 1.483 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0007233/2.803, allocations: 15.64 kB / 1.924 GB, free: 426.9 MB / 1.483 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.008621/2.811, allocations: 1.069 MB / 1.925 GB, free: 425.8 MB / 1.483 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004407/2.812, allocations: 0.9025 MB / 1.926 GB, free: 424.9 MB / 1.483 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1442/2.956, allocations: 67.93 MB / 1.992 GB, free: 356.9 MB / 1.483 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.2178/3.174, allocations: 138.3 MB / 2.127 GB, free: 217.6 MB / 1.483 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.09295/3.267, allocations: 44.67 MB / 2.171 GB, free: 173.1 MB / 1.483 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.04771/3.314, allocations: 23.42 MB / 2.193 GB, free: 149.6 MB / 1.483 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002805/3.317, allocations: 1.037 MB / 2.194 GB, free: 148.5 MB / 1.483 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.05516/3.372, allocations: 27.08 MB / 2.221 GB, free: 121.3 MB / 1.483 GB
Notification: Performance of pre-optimization done (n=2284): time 3.019e-05/3.372, allocations: 0 / 2.221 GB, free: 121.3 MB / 1.483 GB
Notification: Performance of matching and sorting (n=2284): time 0.1608/3.533, allocations: 71.2 MB / 2.29 GB, free: 49.75 MB / 1.483 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002322/3.533, allocations: 0.7209 MB / 2.291 GB, free: 48.91 MB / 1.483 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01593/3.549, allocations: 12.99 MB / 2.304 GB, free: 36 MB / 1.483 GB
Notification: Performance of collectPreVariables (initialization): time 0.005646/3.555, allocations: 457.7 kB / 2.304 GB, free: 35.55 MB / 1.483 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006002/3.561, allocations: 9.368 MB / 2.313 GB, free: 26.75 MB / 1.483 GB
Notification: Performance of collectInitialBindings (initialization): time 0.009232/3.57, allocations: 7.855 MB / 2.321 GB, free: 18.83 MB / 1.483 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01245/3.583, allocations: 4.013 MB / 2.325 GB, free: 14.81 MB / 1.483 GB
Notification: Performance of setup shared object (initialization): time 3.33e-05/3.583, allocations: 305.1 kB / 2.325 GB, free: 14.51 MB / 1.483 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.04642/3.629, allocations: 21.04 MB / 2.346 GB, free: 9.449 MB / 1.498 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.05684/3.686, allocations: 23.3 MB / 2.369 GB, free: 1.766 MB / 1.514 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1091/3.795, allocations: 43.38 MB / 2.411 GB, free: 5.941 MB / 1.561 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.59e-05/3.795, allocations: 8 kB / 2.411 GB, free: 5.934 MB / 1.561 GB
Notification: Performance of matching and sorting (n=2558) (initialization): time 1.076/4.871, allocations: 48.18 MB / 2.458 GB, free: 0.4929 GB / 1.561 GB
Notification: Performance of prepare postOptimizeDAE: time 5.243e-05/4.871, allocations: 18.31 kB / 2.458 GB, free: 0.4929 GB / 1.561 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.888e-05/4.871, allocations: 22.94 kB / 2.458 GB, free: 0.4929 GB / 1.561 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003229/4.874, allocations: 1.503 MB / 2.46 GB, free: 0.4925 GB / 1.561 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.03955/4.914, allocations: 7.16 MB / 2.467 GB, free: 0.4921 GB / 1.561 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01803/4.932, allocations: 18.52 MB / 2.485 GB, free: 492 MB / 1.561 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03229/4.964, allocations: 4.889 MB / 2.489 GB, free: 491.7 MB / 1.561 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005865/4.97, allocations: 0.8978 MB / 2.49 GB, free: 491.5 MB / 1.561 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 102
 * Number of states: 0 ()
 * Number of discrete variables: 196 ($PRE.romHeaMet.internalGains.nextTimeEvent,$whenCondition50,$PRE.romHeaUnm.internalGains.nextTimeEvent,$whenCondition32,$PRE.romCooMet.internalGains.nextTimeEvent,$whenCondition14,$PRE.romCooUnm.internalGains.nextTimeEvent,$whenCondition1,romHeaUnm.internalGains.nextTimeEventScaled,$PRE.romHeaUnm.internalGains.nextTimeEventScaled,romHeaUnm.internalGains.nextTimeEvent,romHeaUnm.HDirTil[6].incAng.decAng.tNext,$PRE.romHeaUnm.HDirTil[6].incAng.decAng.tNext,romHeaUnm.HDirTil[5].incAng.decAng.tNext,$PRE.romHeaUnm.HDirTil[5].incAng.decAng.tNext,romHeaUnm.HDirTil[4].incAng.decAng.tNext,$PRE.romHeaUnm.HDirTil[4].incAng.decAng.tNext,romHeaUnm.HDirTil[3].incAng.decAng.tNext,$PRE.romHeaUnm.HDirTil[3].incAng.decAng.tNext,romHeaUnm.HDirTil[2].incAng.decAng.tNext,$PRE.romHeaUnm.HDirTil[2].incAng.decAng.tNext,romHeaUnm.HDirTil[1].incAng.decAng.tNext,$PRE.romHeaUnm.HDirTil[1].incAng.decAng.tNext,romHeaUnm.HDifTil[6].incAng.decAng.tNext,$PRE.romHeaUnm.HDifTil[6].incAng.decAng.tNext,romHeaUnm.HDifTil[5].incAng.decAng.tNext,$PRE.romHeaUnm.HDifTil[5].incAng.decAng.tNext,romHeaUnm.HDifTil[4].incAng.decAng.tNext,$PRE.romHeaUnm.HDifTil[4].incAng.decAng.tNext,romHeaUnm.HDifTil[3].incAng.decAng.tNext,$PRE.romHeaUnm.HDifTil[3].incAng.decAng.tNext,romHeaUnm.HDifTil[2].incAng.decAng.tNext,$PRE.romHeaUnm.HDifTil[2].incAng.decAng.tNext,romHeaUnm.HDifTil[1].incAng.decAng.tNext,$PRE.romHeaUnm.HDifTil[1].incAng.decAng.tNext,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,romHeaMet.internalGains.nextTimeEventScaled,$PRE.romHeaMet.internalGains.nextTimeEventScaled,romHeaMet.internalGains.nextTimeEvent,romHeaMet.HDirTil[6].incAng.decAng.tNext,$PRE.romHeaMet.HDirTil[6].incAng.decAng.tNext,romHeaMet.HDirTil[5].incAng.decAng.tNext,$PRE.romHeaMet.HDirTil[5].incAng.decAng.tNext,romHeaMet.HDirTil[4].incAng.decAng.tNext,$PRE.romHeaMet.HDirTil[4].incAng.decAng.tNext,romHeaMet.HDirTil[3].incAng.decAng.tNext,$PRE.romHeaMet.HDirTil[3].incAng.decAng.tNext,romHeaMet.HDirTil[2].incAng.decAng.tNext,$PRE.romHeaMet.HDirTil[2].incAng.decAng.tNext,romHeaMet.HDirTil[1].incAng.decAng.tNext,$PRE.romHeaMet.HDirTil[1].incAng.decAng.tNext,romHeaMet.HDifTil[6].incAng.decAng.tNext,$PRE.romHeaMet.HDifTil[6].incAng.decAng.tNext,romHeaMet.HDifTil[5].incAng.decAng.tNext,$PRE.romHeaMet.HDifTil[5].incAng.decAng.tNext,romHeaMet.HDifTil[4].incAng.decAng.tNext,$PRE.romHeaMet.HDifTil[4].incAng.decAng.tNext,romHeaMet.HDifTil[3].incAng.decAng.tNext,$PRE.romHeaMet.HDifTil[3].incAng.decAng.tNext,romHeaMet.HDifTil[2].incAng.decAng.tNext,$PRE.romHeaMet.HDifTil[2].incAng.decAng.tNext,romHeaMet.HDifTil[1].incAng.decAng.tNext,$PRE.romHeaMet.HDifTil[1].incAng.decAng.tNext,$whenCondition33,$whenCondition34,$whenCondition35,$whenCondition36,$whenCondition37,$whenCondition38,$whenCondition39,$whenCondition40,$whenCondition41,$whenCondition42,$whenCondition43,$whenCondition44,$whenCondition45,$whenCondition46,$whenCondition47,$whenCondition48,$whenCondition49,$whenCondition51,$whenCondition52,$whenCondition53,$whenCondition54,$whenCondition55,$whenCondition56,$whenCondition57,$whenCondition58,$whenCondition59,$whenCondition60,$whenCondition61,$whenCondition62,romCooUnm.internalGains.nextTimeEventScaled,$PRE.romCooUnm.internalGains.nextTimeEventScaled,romCooUnm.internalGains.nextTimeEvent,romCooUnm.HDirTil[6].incAng.decAng.tNext,$PRE.romCooUnm.HDirTil[6].incAng.decAng.tNext,romCooUnm.HDirTil[5].incAng.decAng.tNext,$PRE.romCooUnm.HDirTil[5].incAng.decAng.tNext,romCooUnm.HDirTil[4].incAng.decAng.tNext,$PRE.romCooUnm.HDirTil[4].incAng.decAng.tNext,romCooUnm.HDirTil[3].incAng.decAng.tNext,$PRE.romCooUnm.HDirTil[3].incAng.decAng.tNext,romCooUnm.HDirTil[2].incAng.decAng.tNext,$PRE.romCooUnm.HDirTil[2].incAng.decAng.tNext,romCooUnm.HDirTil[1].incAng.decAng.tNext,$PRE.romCooUnm.HDirTil[1].incAng.decAng.tNext,romCooUnm.HDifTil[6].incAng.decAng.tNext,$PRE.romCooUnm.HDifTil[6].incAng.decAng.tNext,romCooUnm.HDifTil[5].incAng.decAng.tNext,$PRE.romCooUnm.HDifTil[5].incAng.decAng.tNext,romCooUnm.HDifTil[4].incAng.decAng.tNext,$PRE.romCooUnm.HDifTil[4].incAng.decAng.tNext,romCooUnm.HDifTil[3].incAng.decAng.tNext,$PRE.romCooUnm.HDifTil[3].incAng.decAng.tNext,romCooUnm.HDifTil[2].incAng.decAng.tNext,$PRE.romCooUnm.HDifTil[2].incAng.decAng.tNext,romCooUnm.HDifTil[1].incAng.decAng.tNext,$PRE.romCooUnm.HDifTil[1].incAng.decAng.tNext,romCooMet.internalGains.nextTimeEventScaled,$PRE.romCooMet.internalGains.nextTimeEventScaled,romCooMet.internalGains.nextTimeEvent,romCooMet.HDirTil[6].incAng.decAng.tNext,$PRE.romCooMet.HDirTil[6].incAng.decAng.tNext,romCooMet.HDirTil[5].incAng.decAng.tNext,$PRE.romCooMet.HDirTil[5].incAng.decAng.tNext,romCooMet.HDirTil[4].incAng.decAng.tNext,$PRE.romCooMet.HDirTil[4].incAng.decAng.tNext,romCooMet.HDirTil[3].incAng.decAng.tNext,$PRE.romCooMet.HDirTil[3].incAng.decAng.tNext,romCooMet.HDirTil[2].incAng.decAng.tNext,$PRE.romCooMet.HDirTil[2].incAng.decAng.tNext,romCooMet.HDirTil[1].incAng.decAng.tNext,$PRE.romCooMet.HDirTil[1].incAng.decAng.tNext,romCooMet.HDifTil[6].incAng.decAng.tNext,$PRE.romCooMet.HDifTil[6].incAng.decAng.tNext,romCooMet.HDifTil[5].incAng.decAng.tNext,$PRE.romCooMet.HDifTil[5].incAng.decAng.tNext,romCooMet.HDifTil[4].incAng.decAng.tNext,$PRE.romCooMet.HDifTil[4].incAng.decAng.tNext,romCooMet.HDifTil[3].incAng.decAng.tNext,$PRE.romCooMet.HDifTil[3].incAng.decAng.tNext,romCooMet.HDifTil[2].incAng.decAng.tNext,$PRE.romCooMet.HDifTil[2].incAng.decAng.tNext,romCooMet.HDifTil[1].incAng.decAng.tNext,$PRE.romCooMet.HDifTil[1].incAng.decAng.tNext,weaDat1.decAng.tNext,$PRE.weaDat1.decAng.tNext,weaDat1.eqnTim.tNext,$PRE.weaDat1.eqnTim.tNext,weaDat1.conTim.tNext,$PRE.weaDat1.conTim.tNext,weaDat1.conTimMin.tNext,$PRE.weaDat1.conTimMin.tNext,weaDat1.locTim.tNext,$PRE.weaDat1.locTim.tNext,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,$whenCondition24,$whenCondition25,$whenCondition26,$whenCondition27,$whenCondition28,$whenCondition29,$whenCondition30,$whenCondition31,conCoo.I.trigger_internal,conHea.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2438):
 * Single equations (assignments): 2434
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(3,28,100.0%), (3,28,100.0%), (3,28,100.0%), (3,28,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.01875/4.989, allocations: 8.261 MB / 2.498 GB, free: 487.8 MB / 1.561 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.007046/4.996, allocations: 1.779 MB / 2.5 GB, free: 487.7 MB / 1.561 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1238/5.119, allocations: 53.72 MB / 2.553 GB, free: 460.5 MB / 1.561 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001365/5.12, allocations: 224 kB / 2.553 GB, free: 460.3 MB / 1.561 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.875e-05/5.12, allocations: 24 kB / 2.553 GB, free: 460.3 MB / 1.561 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0004164/5.12, allocations: 115.5 kB / 2.553 GB, free: 460.2 MB / 1.561 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.04588/5.166, allocations: 35.27 MB / 2.587 GB, free: 425.8 MB / 1.561 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0002554/5.166, allocations: 0 / 2.587 GB, free: 425.8 MB / 1.561 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.03551/5.202, allocations: 6.716 MB / 2.594 GB, free: 419 MB / 1.561 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002888/5.205, allocations: 1.455 MB / 2.595 GB, free: 417.6 MB / 1.561 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.005458/5.21, allocations: 0.6633 MB / 2.596 GB, free: 416.9 MB / 1.561 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01727/5.227, allocations: 24.57 MB / 2.62 GB, free: 391.3 MB / 1.561 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.423e-06/5.227, allocations: 4 kB / 2.62 GB, free: 391.3 MB / 1.561 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1539/5.381, allocations: 79.62 MB / 2.698 GB, free: 311.5 MB / 1.561 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01423/5.396, allocations: 7.029 MB / 2.705 GB, free: 304.8 MB / 1.561 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005282/5.401, allocations: 0.5967 MB / 2.705 GB, free: 304.2 MB / 1.561 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02621/5.427, allocations: 3.548 MB / 2.709 GB, free: 300.7 MB / 1.561 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003581/5.431, allocations: 1.649 MB / 2.71 GB, free: 299 MB / 1.561 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002691/5.433, allocations: 0.8313 MB / 2.711 GB, free: 298.2 MB / 1.561 GB
Notification: Performance of sorting global known variables: time 0.01243/5.446, allocations: 9.786 MB / 2.721 GB, free: 288.4 MB / 1.561 GB
Notification: Performance of sort global known variables: time 1.1e-07/5.446, allocations: 0 / 2.721 GB, free: 288.4 MB / 1.561 GB
Notification: Performance of remove unused functions: time 0.0227/5.468, allocations: 7.665 MB / 2.728 GB, free: 281.3 MB / 1.561 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 2
 * Number of states: 24 (romHeaMet.thermalZoneTwoElements.volAir.dynBal.medium.Xi[1],romHeaMet.thermalZoneTwoElements.volAir.dynBal.U,romHeaMet.thermalZoneTwoElements.volAir.dynBal.m,romHeaMet.thermalZoneTwoElements.extWallRC.thermCapExt[1].T,romHeaMet.thermalZoneTwoElements.intWallRC.thermCapInt[1].T,conHea.I.y,romHeaUnm.thermalZoneTwoElements.volAir.dynBal.medium.Xi[1],romHeaUnm.thermalZoneTwoElements.volAir.dynBal.U,romHeaUnm.thermalZoneTwoElements.volAir.dynBal.m,romHeaUnm.thermalZoneTwoElements.extWallRC.thermCapExt[1].T,romHeaUnm.thermalZoneTwoElements.intWallRC.thermCapInt[1].T,rooOdeHea.TAir,conCoo.I.y,rooOdeCoo.TAir,romCooMet.thermalZoneTwoElements.volAir.dynBal.medium.Xi[1],romCooMet.thermalZoneTwoElements.volAir.dynBal.U,romCooMet.thermalZoneTwoElements.volAir.dynBal.m,romCooMet.thermalZoneTwoElements.extWallRC.thermCapExt[1].T,romCooMet.thermalZoneTwoElements.intWallRC.thermCapInt[1].T,romCooUnm.thermalZoneTwoElements.volAir.dynBal.medium.Xi[1],romCooUnm.thermalZoneTwoElements.volAir.dynBal.U,romCooUnm.thermalZoneTwoElements.volAir.dynBal.m,romCooUnm.thermalZoneTwoElements.extWallRC.thermCapExt[1].T,romCooUnm.thermalZoneTwoElements.intWallRC.thermCapInt[1].T)
 * Number of discrete variables: 128 ($whenCondition62,$whenCondition61,$whenCondition60,$whenCondition59,$whenCondition58,$whenCondition57,$whenCondition56,$whenCondition55,$whenCondition54,$whenCondition53,$whenCondition52,$whenCondition51,$whenCondition50,$whenCondition49,$whenCondition48,$whenCondition47,$whenCondition46,$whenCondition45,$whenCondition44,$whenCondition43,$whenCondition42,$whenCondition41,$whenCondition40,$whenCondition39,$whenCondition38,$whenCondition37,$whenCondition36,$whenCondition35,$whenCondition34,$whenCondition33,$whenCondition32,romHeaMet.HDifTil[1].incAng.decAng.tNext,romHeaMet.HDifTil[2].incAng.decAng.tNext,romHeaMet.HDifTil[3].incAng.decAng.tNext,romHeaMet.HDifTil[4].incAng.decAng.tNext,romHeaMet.HDifTil[5].incAng.decAng.tNext,romHeaMet.HDifTil[6].incAng.decAng.tNext,romHeaMet.HDirTil[1].incAng.decAng.tNext,romHeaMet.HDirTil[2].incAng.decAng.tNext,romHeaMet.HDirTil[3].incAng.decAng.tNext,romHeaMet.HDirTil[4].incAng.decAng.tNext,romHeaMet.HDirTil[5].incAng.decAng.tNext,romHeaMet.HDirTil[6].incAng.decAng.tNext,romHeaMet.internalGains.nextTimeEvent,romHeaMet.internalGains.nextTimeEventScaled,weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,romHeaUnm.HDifTil[1].incAng.decAng.tNext,romHeaUnm.HDifTil[2].incAng.decAng.tNext,romHeaUnm.HDifTil[3].incAng.decAng.tNext,romHeaUnm.HDifTil[4].incAng.decAng.tNext,romHeaUnm.HDifTil[5].incAng.decAng.tNext,romHeaUnm.HDifTil[6].incAng.decAng.tNext,romHeaUnm.HDirTil[1].incAng.decAng.tNext,romHeaUnm.HDirTil[2].incAng.decAng.tNext,romHeaUnm.HDirTil[3].incAng.decAng.tNext,romHeaUnm.HDirTil[4].incAng.decAng.tNext,romHeaUnm.HDirTil[5].incAng.decAng.tNext,romHeaUnm.HDirTil[6].incAng.decAng.tNext,romHeaUnm.internalGains.nextTimeEvent,romHeaUnm.internalGains.nextTimeEventScaled,$whenCondition31,$whenCondition30,$whenCondition29,$whenCondition28,$whenCondition27,$whenCondition26,$whenCondition25,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,weaDat1.locTim.tNext,weaDat1.conTimMin.tNext,weaDat1.conTim.tNext,weaDat1.eqnTim.tNext,weaDat1.decAng.tNext,romCooMet.HDifTil[1].incAng.decAng.tNext,romCooMet.HDifTil[2].incAng.decAng.tNext,romCooMet.HDifTil[3].incAng.decAng.tNext,romCooMet.HDifTil[4].incAng.decAng.tNext,romCooMet.HDifTil[5].incAng.decAng.tNext,romCooMet.HDifTil[6].incAng.decAng.tNext,romCooMet.HDirTil[1].incAng.decAng.tNext,romCooMet.HDirTil[2].incAng.decAng.tNext,romCooMet.HDirTil[3].incAng.decAng.tNext,romCooMet.HDirTil[4].incAng.decAng.tNext,romCooMet.HDirTil[5].incAng.decAng.tNext,romCooMet.HDirTil[6].incAng.decAng.tNext,romCooMet.internalGains.nextTimeEvent,romCooMet.internalGains.nextTimeEventScaled,romCooUnm.HDifTil[1].incAng.decAng.tNext,romCooUnm.HDifTil[2].incAng.decAng.tNext,romCooUnm.HDifTil[3].incAng.decAng.tNext,romCooUnm.HDifTil[4].incAng.decAng.tNext,romCooUnm.HDifTil[5].incAng.decAng.tNext,romCooUnm.HDifTil[6].incAng.decAng.tNext,romCooUnm.HDirTil[1].incAng.decAng.tNext,romCooUnm.HDirTil[2].incAng.decAng.tNext,romCooUnm.HDirTil[3].incAng.decAng.tNext,romCooUnm.HDirTil[4].incAng.decAng.tNext,romCooUnm.HDirTil[5].incAng.decAng.tNext,romCooUnm.HDirTil[6].incAng.decAng.tNext,romCooUnm.internalGains.nextTimeEvent,romCooUnm.internalGains.nextTimeEventScaled)
 * Number of discrete states: 66 (romCooUnm.internalGains.nextTimeEvent,romCooUnm.HDirTil[6].incAng.decAng.tNext,romCooUnm.HDirTil[5].incAng.decAng.tNext,romCooUnm.HDirTil[4].incAng.decAng.tNext,romCooUnm.HDirTil[3].incAng.decAng.tNext,romCooUnm.HDirTil[2].incAng.decAng.tNext,romCooUnm.HDirTil[1].incAng.decAng.tNext,romCooUnm.HDifTil[6].incAng.decAng.tNext,romCooUnm.HDifTil[5].incAng.decAng.tNext,romCooUnm.HDifTil[4].incAng.decAng.tNext,romCooUnm.HDifTil[3].incAng.decAng.tNext,romCooUnm.HDifTil[2].incAng.decAng.tNext,romCooUnm.HDifTil[1].incAng.decAng.tNext,romCooMet.internalGains.nextTimeEvent,romCooMet.HDirTil[6].incAng.decAng.tNext,romCooMet.HDirTil[5].incAng.decAng.tNext,romCooMet.HDirTil[4].incAng.decAng.tNext,romCooMet.HDirTil[3].incAng.decAng.tNext,romCooMet.HDirTil[2].incAng.decAng.tNext,romCooMet.HDirTil[1].incAng.decAng.tNext,romCooMet.HDifTil[6].incAng.decAng.tNext,romCooMet.HDifTil[5].incAng.decAng.tNext,romCooMet.HDifTil[4].incAng.decAng.tNext,romCooMet.HDifTil[3].incAng.decAng.tNext,romCooMet.HDifTil[2].incAng.decAng.tNext,romCooMet.HDifTil[1].incAng.decAng.tNext,weaDat1.decAng.tNext,weaDat1.eqnTim.tNext,weaDat1.conTim.tNext,weaDat1.conTimMin.tNext,weaDat1.locTim.tNext,romCooUnm.internalGains.nextTimeEventScaled,romCooMet.internalGains.nextTimeEventScaled,romHeaUnm.internalGains.nextTimeEvent,romHeaUnm.HDirTil[6].incAng.decAng.tNext,romHeaUnm.HDirTil[5].incAng.decAng.tNext,romHeaUnm.HDirTil[4].incAng.decAng.tNext,romHeaUnm.HDirTil[3].incAng.decAng.tNext,romHeaUnm.HDirTil[2].incAng.decAng.tNext,romHeaUnm.HDirTil[1].incAng.decAng.tNext,romHeaUnm.HDifTil[6].incAng.decAng.tNext,romHeaUnm.HDifTil[5].incAng.decAng.tNext,romHeaUnm.HDifTil[4].incAng.decAng.tNext,romHeaUnm.HDifTil[3].incAng.decAng.tNext,romHeaUnm.HDifTil[2].incAng.decAng.tNext,romHeaUnm.HDifTil[1].incAng.decAng.tNext,weaDat.decAng.tNext,weaDat.eqnTim.tNext,weaDat.conTim.tNext,weaDat.conTimMin.tNext,weaDat.locTim.tNext,romHeaMet.internalGains.nextTimeEvent,romHeaMet.HDirTil[6].incAng.decAng.tNext,romHeaMet.HDirTil[5].incAng.decAng.tNext,romHeaMet.HDirTil[4].incAng.decAng.tNext,romHeaMet.HDirTil[3].incAng.decAng.tNext,romHeaMet.HDirTil[2].incAng.decAng.tNext,romHeaMet.HDirTil[1].incAng.decAng.tNext,romHeaMet.HDifTil[6].incAng.decAng.tNext,romHeaMet.HDifTil[5].incAng.decAng.tNext,romHeaMet.HDifTil[4].incAng.decAng.tNext,romHeaMet.HDifTil[3].incAng.decAng.tNext,romHeaMet.HDifTil[2].incAng.decAng.tNext,romHeaMet.HDifTil[1].incAng.decAng.tNext,romHeaUnm.internalGains.nextTimeEventScaled,romHeaMet.internalGains.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (2284):
 * Single equations (assignments): 2210
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 66
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 8
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 8 systems
   {(3,25,100.0%), (3,25,100.0%), (1,3,100.0%), (1,3,100.0%), (3,25,100.0%), (3,25,100.0%), (1,3,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.1645/5.633, allocations: 81.94 MB / 2.808 GB, free: 199.6 MB / 1.561 GB
Notification: Performance of simCode: created initialization part: time 0.1038/5.737, allocations: 46.78 MB / 2.854 GB, free: 152.7 MB / 1.561 GB
Notification: Performance of simCode: created event and clocks part: time 7.985e-06/5.737, allocations: 0.5625 kB / 2.854 GB, free: 152.7 MB / 1.561 GB
Notification: Performance of simCode: created simulation system equations: time 0.05372/5.79, allocations: 24.64 MB / 2.878 GB, free: 128 MB / 1.561 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02983/5.82, allocations: 4.2 MB / 2.882 GB, free: 123.9 MB / 1.561 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 1.005/6.825, allocations: 252.7 MB / 3.129 GB, free: 472.8 MB / 1.576 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01667/6.842, allocations: 15.76 MB / 3.144 GB, free: 466.2 MB / 1.576 GB
Notification: Performance of simCode: alias equations: time 0.03244/6.875, allocations: 10.27 MB / 3.154 GB, free: 461.4 MB / 1.576 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02163/6.896, allocations: 11.8 MB / 3.166 GB, free: 449.6 MB / 1.576 GB
Notification: Performance of SimCode: time 1.203e-06/6.896, allocations: 4 kB / 3.166 GB, free: 449.6 MB / 1.576 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.057/7.953, allocations: 0.5044 GB / 3.67 GB, free: 498.8 MB / 1.592 GB
Notification: Performance of buildModelFMU: Generate platform static: time 66.36/74.32, allocations: 6.406 kB / 3.67 GB, free: 498.8 MB / 1.592 GB
"
[Timeout remaining time 225]
(rm -f Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE.pipe ; mkfifo Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE.pipe ; head -c 1048576 < Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE.pipe >> ../files/Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE.sim & python3 -m fmpy simulate  --output-file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv --start-time 0 --stop-time 1.2096e+06 --timeout 400 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 483.84 Buildings_10_Buildings_Experimental_DHC_Loads_BaseClasses_Validation_SimpleRoomODE.fmu > Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE.pipe 2>&1) [Timeout 420.0]
diffSimulationResults("Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv","/mnt/ReferenceFiles/Buildings/csv/maint_10.0.x/Buildings_Experimental_DHC_Loads_BaseClasses_Validation_SimpleRoomODE.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
"Error: Could not read variable romHeaUnm.TAir in file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv.
Warning: Get data of variable romHeaUnm.TAir from file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv failed!
Error: Could not read variable rooOdeHea.TAir in file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv.
Warning: Get data of variable rooOdeHea.TAir from file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv failed!
Error: Could not read variable romCooUnm.TAir in file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv.
Warning: Get data of variable romCooUnm.TAir from file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv failed!
Error: Could not read variable rooOdeCoo.TAir in file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv.
Warning: Get data of variable rooOdeCoo.TAir from file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv failed!
Error: Could not read variable rooOdeHea.QReq_flow in file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv.
Warning: Get data of variable rooOdeHea.QReq_flow from file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv failed!
Error: Could not read variable rooOdeCoo.QReq_flow in file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv.
Warning: Get data of variable rooOdeCoo.QReq_flow from file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv failed!
Error: Could not read variable rooOdeHea.QAct_flow in file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv.
Warning: Get data of variable rooOdeHea.QAct_flow from file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv failed!
Error: Could not read variable rooOdeCoo.QAct_flow in file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv.
Warning: Get data of variable rooOdeCoo.QAct_flow from file Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.SimpleRoomODE_res.csv failed!
"
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 84.24209500899451]