Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Examples.Tutorial.SimpleHouse.SimpleHouse3.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 12.0.0-master/package.mo", uses=false)
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/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.Examples.Tutorial.SimpleHouse.SimpleHouse3,fileNamePrefix="Buildings_latest_Buildings_Examples_Tutorial_SimpleHouse_SimpleHouse3",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Examples.Tutorial.SimpleHouse.SimpleHouse3,fileNamePrefix="Buildings_latest_Buildings_Examples_Tutorial_SimpleHouse_SimpleHouse3",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0082/0.0082, allocations: 97.81 kB / 15.73 MB, free: 5.961 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.002164/0.002164, allocations: 195.4 kB / 16.67 MB, free: 5.883 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.626/1.626, allocations: 222.9 MB / 240.4 MB, free: 15.09 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.661/2.661, allocations: 472.7 MB / 0.7453 GB, free: 468 kB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001418/0.001418, allocations: 63.91 kB / 1.069 GB, free: 10.03 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7477/0.7491, allocations: 159.9 MB / 1.225 GB, free: 13.4 MB / 0.9512 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.Tutorial.SimpleHouse.SimpleHouse3): time 0.1657/0.9148, allocations: 166.1 MB / 1.387 GB, free: 6.688 MB / 1.107 GB
Notification: Performance of NFInst.instExpressions: time 0.0116/0.9264, allocations: 7.81 MB / 1.395 GB, free: 14.86 MB / 1.123 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001295/0.9277, allocations: 31.81 kB / 1.395 GB, free: 14.83 MB / 1.123 GB
Notification: Performance of NFTyping.typeComponents: time 0.00132/0.9291, allocations: 417 kB / 1.395 GB, free: 14.42 MB / 1.123 GB
Notification: Performance of NFTyping.typeBindings: time 0.003609/0.9328, allocations: 1.341 MB / 1.397 GB, free: 13.07 MB / 1.123 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002764/0.9355, allocations: 1.181 MB / 1.398 GB, free: 11.9 MB / 1.123 GB
Notification: Performance of NFFlatten.flatten: time 0.002819/0.9384, allocations: 2.356 MB / 1.4 GB, free: 9.539 MB / 1.123 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001701/0.9401, allocations: 1.19 MB / 1.401 GB, free: 8.328 MB / 1.123 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001328/0.9414, allocations: 0.834 MB / 1.402 GB, free: 7.492 MB / 1.123 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001547/0.943, allocations: 0.791 MB / 1.403 GB, free: 6.699 MB / 1.123 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003429/0.9434, allocations: 152 kB / 1.403 GB, free: 6.551 MB / 1.123 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00247/0.9458, allocations: 1.123 MB / 1.404 GB, free: 5.426 MB / 1.123 GB
Notification: Performance of NFScalarize.scalarize: time 0.0005017/0.9463, allocations: 426.6 kB / 1.405 GB, free: 5.008 MB / 1.123 GB
Notification: Performance of NFVerifyModel.verify: time 0.001014/0.9474, allocations: 0.7813 MB / 1.405 GB, free: 4.223 MB / 1.123 GB
Notification: Performance of NFConvertDAE.convert: time 0.003642/0.951, allocations: 2.421 MB / 1.408 GB, free: 1.793 MB / 1.123 GB
Notification: Performance of FrontEnd - DAE generated: time 4.148e-06/0.951, allocations: 0 / 1.408 GB, free: 1.793 MB / 1.123 GB
Notification: Performance of FrontEnd: time 1.382e-06/0.951, allocations: 4 kB / 1.408 GB, free: 1.789 MB / 1.123 GB
Notification: Performance of Transformations before backend: time 5.927e-05/0.9511, allocations: 0 / 1.408 GB, free: 1.789 MB / 1.123 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 279
 * Number of variables: 279
Notification: Performance of Generate backend data structure: time 0.003852/0.955, allocations: 1.931 MB / 1.41 GB, free: 15.79 MB / 1.139 GB
Notification: Performance of prepare preOptimizeDAE: time 4.09e-05/0.955, allocations: 12.03 kB / 1.41 GB, free: 15.78 MB / 1.139 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0002508/0.9553, allocations: 176.8 kB / 1.41 GB, free: 15.6 MB / 1.139 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00193/0.9572, allocations: 338.6 kB / 1.41 GB, free: 15.27 MB / 1.139 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001718/0.9589, allocations: 1.023 MB / 1.411 GB, free: 14.2 MB / 1.139 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.929e-05/0.959, allocations: 86.2 kB / 1.411 GB, free: 14.11 MB / 1.139 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001586/0.9592, allocations: 108 kB / 1.411 GB, free: 14.01 MB / 1.139 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001991/0.9612, allocations: 1.176 MB / 1.412 GB, free: 12.76 MB / 1.139 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.879e-05/0.9612, allocations: 0 / 1.412 GB, free: 12.76 MB / 1.139 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001084/0.9614, allocations: 48 kB / 1.412 GB, free: 12.71 MB / 1.139 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.428e-05/0.9614, allocations: 42.06 kB / 1.413 GB, free: 12.67 MB / 1.139 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002194/0.9636, allocations: 1.304 MB / 1.414 GB, free: 11.36 MB / 1.139 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.005801/0.9694, allocations: 3.812 MB / 1.418 GB, free: 7.34 MB / 1.139 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002038/0.9715, allocations: 1.001 MB / 1.419 GB, free: 6.332 MB / 1.139 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007179/0.9722, allocations: 404.7 kB / 1.419 GB, free: 5.93 MB / 1.139 GB
Notification: Performance of preOpt evalFunc (simulation): time 9.091e-05/0.9723, allocations: 29.03 kB / 1.419 GB, free: 5.902 MB / 1.139 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001038/0.9733, allocations: 0.5913 MB / 1.42 GB, free: 5.293 MB / 1.139 GB
Notification: Performance of pre-optimization done (n=102): time 4.157e-06/0.9734, allocations: 0 / 1.42 GB, free: 5.293 MB / 1.139 GB
Notification: Performance of matching and sorting (n=102): time 0.003593/0.977, allocations: 1.446 MB / 1.421 GB, free: 3.82 MB / 1.139 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.327e-05/0.9771, allocations: 192.9 kB / 1.421 GB, free: 3.59 MB / 1.139 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001161/0.9782, allocations: 0.8341 MB / 1.422 GB, free: 2.73 MB / 1.139 GB
Notification: Performance of collectPreVariables (initialization): time 8.718e-05/0.9783, allocations: 41.7 kB / 1.422 GB, free: 2.684 MB / 1.139 GB
Notification: Performance of collectInitialEqns (initialization): time 0.000418/0.9788, allocations: 0.5363 MB / 1.422 GB, free: 2.141 MB / 1.139 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002963/0.9791, allocations: 364.9 kB / 1.423 GB, free: 1.781 MB / 1.139 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002867/0.9794, allocations: 178.6 kB / 1.423 GB, free: 1.598 MB / 1.139 GB
Notification: Performance of setup shared object (initialization): time 0.0001176/0.9795, allocations: 341.9 kB / 1.423 GB, free: 1.258 MB / 1.139 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006252/0.9801, allocations: 317.8 kB / 1.424 GB, free: 0.9492 MB / 1.139 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007509/0.9809, allocations: 467.7 kB / 1.424 GB, free: 460 kB / 1.139 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00135/0.9822, allocations: 0.7738 MB / 1.425 GB, free: 15.64 MB / 1.154 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.482e-06/0.9823, allocations: 8 kB / 1.425 GB, free: 15.63 MB / 1.154 GB
Notification: Performance of matching and sorting (n=118) (initialization): time 0.002249/0.9845, allocations: 1.029 MB / 1.426 GB, free: 14.6 MB / 1.154 GB
Notification: Performance of prepare postOptimizeDAE: time 2.041e-05/0.9846, allocations: 8 kB / 1.426 GB, free: 14.59 MB / 1.154 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.056e-05/0.9846, allocations: 4 kB / 1.426 GB, free: 14.59 MB / 1.154 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005822/0.9852, allocations: 81 kB / 1.426 GB, free: 14.5 MB / 1.154 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008066/0.986, allocations: 207.7 kB / 1.426 GB, free: 14.3 MB / 1.154 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002119/0.9881, allocations: 1.66 MB / 1.428 GB, free: 12.5 MB / 1.154 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009663/0.9891, allocations: 109.1 kB / 1.428 GB, free: 12.39 MB / 1.154 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.548e-05/0.9892, allocations: 44.05 kB / 1.428 GB, free: 12.35 MB / 1.154 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 10
 * Number of states: 0 ()
 * Number of discrete variables: 15 (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,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (116):
 * Single equations (assignments): 115
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.0005323/0.9897, allocations: 314.1 kB / 1.428 GB, free: 12.03 MB / 1.154 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002434/0.99, allocations: 123.2 kB / 1.428 GB, free: 11.91 MB / 1.154 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002787/0.9928, allocations: 1.24 MB / 1.43 GB, free: 10.65 MB / 1.154 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.207e-05/0.9928, allocations: 12 kB / 1.43 GB, free: 10.64 MB / 1.154 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.409e-06/0.9928, allocations: 0 / 1.43 GB, free: 10.64 MB / 1.154 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.576e-05/0.9928, allocations: 7.969 kB / 1.43 GB, free: 10.63 MB / 1.154 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001635/0.9945, allocations: 1.181 MB / 1.431 GB, free: 9.402 MB / 1.154 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.407e-06/0.9945, allocations: 0 / 1.431 GB, free: 9.402 MB / 1.154 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0008952/0.9954, allocations: 203.8 kB / 1.431 GB, free: 9.203 MB / 1.154 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0004472/0.9959, allocations: 76.72 kB / 1.431 GB, free: 9.125 MB / 1.154 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.509e-05/0.996, allocations: 31.98 kB / 1.431 GB, free: 9.094 MB / 1.154 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001838/0.9978, allocations: 1.662 MB / 1.433 GB, free: 7.285 MB / 1.154 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.373e-06/0.9978, allocations: 0 / 1.433 GB, free: 7.285 MB / 1.154 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003061/1.001, allocations: 1.582 MB / 1.434 GB, free: 5.68 MB / 1.154 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000493/1.001, allocations: 324 kB / 1.434 GB, free: 5.344 MB / 1.154 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001921/1.002, allocations: 27.98 kB / 1.434 GB, free: 5.316 MB / 1.154 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000874/1.002, allocations: 63.94 kB / 1.435 GB, free: 5.254 MB / 1.154 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001716/1.003, allocations: 84.88 kB / 1.435 GB, free: 5.172 MB / 1.154 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 9.11e-05/1.003, allocations: 47.97 kB / 1.435 GB, free: 5.125 MB / 1.154 GB
Notification: Performance of sorting global known variables: time 0.0007965/1.004, allocations: 0.5821 MB / 1.435 GB, free: 4.531 MB / 1.154 GB
Notification: Performance of sort global known variables: time 2.41e-07/1.004, allocations: 0 / 1.435 GB, free: 4.531 MB / 1.154 GB
Notification: Performance of remove unused functions: time 0.001051/1.005, allocations: 427 kB / 1.436 GB, free: 4.113 MB / 1.154 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 4 (walCap.T,zon.dynBal.medium.Xi[1],zon.dynBal.U,zon.dynBal.m)
 * Number of discrete variables: 10 ($whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext)
 * Number of discrete states: 5 (weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (113):
 * Single equations (assignments): 107
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 5
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.004757/1.009, allocations: 2.646 MB / 1.438 GB, free: 1.621 MB / 1.154 GB
Notification: Performance of simCode: created initialization part: time 0.001982/1.011, allocations: 0.9721 MB / 1.439 GB, free: 0.6367 MB / 1.154 GB
Notification: Performance of simCode: created event and clocks part: time 5.56e-06/1.011, allocations: 0 / 1.439 GB, free: 0.6367 MB / 1.154 GB
Notification: Performance of simCode: created simulation system equations: time 0.001065/1.012, allocations: 0.6018 MB / 1.44 GB, free: 20 kB / 1.154 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002021/1.015, allocations: 0.4887 MB / 1.44 GB, free: 15.55 MB / 1.17 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01355/1.028, allocations: 8.267 MB / 1.448 GB, free: 7.105 MB / 1.17 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007818/1.029, allocations: 1.161 MB / 1.449 GB, free: 5.918 MB / 1.17 GB
Notification: Performance of simCode: alias equations: time 0.001085/1.03, allocations: 321.1 kB / 1.45 GB, free: 5.602 MB / 1.17 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007404/1.031, allocations: 0.5071 MB / 1.45 GB, free: 5.094 MB / 1.17 GB
Notification: Performance of SimCode: time 1.512e-06/1.031, allocations: 0 / 1.45 GB, free: 5.094 MB / 1.17 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.06361/1.094, allocations: 29.59 MB / 1.479 GB, free: 7.855 MB / 1.201 GB
Notification: Performance of buildModelFMU: Generate platform static: time 13.25/14.35, allocations: 8.578 kB / 1.479 GB, free: 7.848 MB / 1.201 GB
(rm -f Buildings_latest_Buildings.Examples.Tutorial.SimpleHouse.SimpleHouse3.pipe ; mkfifo Buildings_latest_Buildings.Examples.Tutorial.SimpleHouse.SimpleHouse3.pipe ; head -c 1048576 < Buildings_latest_Buildings.Examples.Tutorial.SimpleHouse.SimpleHouse3.pipe >> ../files/Buildings_latest_Buildings.Examples.Tutorial.SimpleHouse.SimpleHouse3.sim & python3 -m fmpy simulate  --output-file Buildings_latest_Buildings.Examples.Tutorial.SimpleHouse.SimpleHouse3_res.csv --start-time 0 --stop-time 1e+06 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 400 Buildings_latest_Buildings_Examples_Tutorial_SimpleHouse_SimpleHouse3.fmu > Buildings_latest_Buildings.Examples.Tutorial.SimpleHouse.SimpleHouse3.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Examples.Tutorial.SimpleHouse.SimpleHouse3_res.csv","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Examples_Tutorial_SimpleHouse_SimpleHouse3.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Examples.Tutorial.SimpleHouse.SimpleHouse3.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches