Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Examples.SimpleHouse.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.0.1-master/package.mo", uses=false)
Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-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: translateModel(Buildings.Examples.SimpleHouse,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|zon.T|heaWat.u|vavDam.y|fan.sta_a.T|fan.sta_b.T",fileNamePrefix="Buildings_latest_Buildings.Examples.SimpleHouse")
translateModel(Buildings.Examples.SimpleHouse,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|zon.T|heaWat.u|vavDam.y|fan.sta_a.T|fan.sta_b.T",fileNamePrefix="Buildings_latest_Buildings.Examples.SimpleHouse")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001158/0.001158, allocations: 105.6 kB / 16.41 MB, free: 6.492 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.001245/0.001245, allocations: 192.3 kB / 17.35 MB, free: 5.738 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.346/1.346, allocations: 222.9 MB / 241 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.733/2.733, allocations: 461.9 MB / 0.7355 GB, free: 11.02 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001574/0.001574, allocations: 67.89 kB / 1.055 GB, free: 7.672 MB / 0.8262 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.9329/0.9345, allocations: 157.4 MB / 1.208 GB, free: 13.57 MB / 0.9356 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.SimpleHouse): time 0.3996/1.334, allocations: 348.5 MB / 1.549 GB, free: 15.86 MB / 1.279 GB
Notification: Performance of NFInst.instExpressions: time 1.153/2.487, allocations: 41.57 MB / 1.589 GB, free: 11.66 MB / 1.279 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0144/2.501, allocations: 224.7 kB / 1.589 GB, free: 11.65 MB / 1.279 GB
Notification: Performance of NFTyping.typeComponents: time 0.01509/2.516, allocations: 3.842 MB / 1.593 GB, free: 11.65 MB / 1.279 GB
Notification: Performance of NFTyping.typeBindings: time 0.02915/2.546, allocations: 8.685 MB / 1.602 GB, free: 11.39 MB / 1.279 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01571/2.561, allocations: 5.369 MB / 1.607 GB, free: 11.26 MB / 1.279 GB
Notification: Performance of NFFlatten.flatten: time 0.03404/2.595, allocations: 23.87 MB / 1.63 GB, free: 11.19 MB / 1.279 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01422/2.61, allocations: 7.542 MB / 1.638 GB, free: 10.23 MB / 1.279 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02415/2.634, allocations: 8.225 MB / 1.646 GB, free: 10.15 MB / 1.279 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01368/2.648, allocations: 5.62 MB / 1.651 GB, free: 9.375 MB / 1.279 GB
Notification: Performance of NFPackage.collectConstants: time 0.004484/2.652, allocations: 0.7888 MB / 1.652 GB, free: 9.375 MB / 1.279 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02056/2.673, allocations: 6.405 MB / 1.658 GB, free: 9.297 MB / 1.279 GB
Notification: Performance of NFScalarize.scalarize: time 0.006344/2.679, allocations: 2.645 MB / 1.661 GB, free: 8.969 MB / 1.279 GB
Notification: Performance of NFVerifyModel.verify: time 0.01752/2.697, allocations: 4.65 MB / 1.665 GB, free: 7.688 MB / 1.279 GB
Notification: Performance of NFConvertDAE.convert: time 0.03671/2.733, allocations: 14.16 MB / 1.679 GB, free: 5.844 MB / 1.279 GB
Notification: Performance of FrontEnd - DAE generated: time 7.485e-06/2.733, allocations: 2.469 kB / 1.679 GB, free: 5.844 MB / 1.279 GB
Notification: Performance of FrontEnd: time 3.146e-06/2.733, allocations: 0 / 1.679 GB, free: 5.844 MB / 1.279 GB
Notification: Performance of Transformations before backend: time 0.0005658/2.734, allocations: 7.938 kB / 1.679 GB, free: 5.836 MB / 1.279 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1222
 * Number of variables: 1222
Notification: Performance of Generate backend data structure: time 0.03627/2.77, allocations: 9.581 MB / 1.689 GB, free: 1.309 MB / 1.279 GB
Notification: Performance of prepare preOptimizeDAE: time 7.239e-05/2.77, allocations: 7.75 kB / 1.689 GB, free: 1.309 MB / 1.279 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01875/2.789, allocations: 2.636 MB / 1.691 GB, free: 172 kB / 1.279 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0243/2.814, allocations: 8.55 MB / 1.699 GB, free: 13.25 MB / 1.295 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006058/2.814, allocations: 381.2 kB / 1.7 GB, free: 13.21 MB / 1.295 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002622/2.817, allocations: 492.7 kB / 1.7 GB, free: 13.06 MB / 1.295 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02004/2.837, allocations: 6.451 MB / 1.707 GB, free: 9.062 MB / 1.295 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001277/2.837, allocations: 23.42 kB / 1.707 GB, free: 9.051 MB / 1.295 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000776/2.838, allocations: 198.9 kB / 1.707 GB, free: 8.902 MB / 1.295 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001976/2.838, allocations: 204.8 kB / 1.707 GB, free: 8.875 MB / 1.295 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01548/2.854, allocations: 6.088 MB / 1.713 GB, free: 2.848 MB / 1.295 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.05874/2.912, allocations: 29.4 MB / 1.742 GB, free: 4.215 MB / 1.326 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01196/2.924, allocations: 3.914 MB / 1.745 GB, free: 328 kB / 1.326 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.006135/2.93, allocations: 2.3 MB / 1.748 GB, free: 14.02 MB / 1.342 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 evalFunc (simulation): time 0.02656/2.957, allocations: 8.913 MB / 1.756 GB, free: 4.973 MB / 1.342 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.006121/2.963, allocations: 2.255 MB / 1.759 GB, free: 2.668 MB / 1.342 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004457/2.968, allocations: 296.4 kB / 1.759 GB, free: 2.375 MB / 1.342 GB
Notification: Performance of pre-optimization done (n=279): time 1.856e-05/2.968, allocations: 0 / 1.759 GB, free: 2.375 MB / 1.342 GB
Notification: Performance of matching and sorting (n=279): time 0.02082/2.989, allocations: 6.636 MB / 1.765 GB, free: 11.54 MB / 1.357 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001263/2.989, allocations: 269 kB / 1.766 GB, free: 11.23 MB / 1.357 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01739/3.006, allocations: 6.744 MB / 1.772 GB, free: 4.52 MB / 1.357 GB
Notification: Performance of collectPreVariables (initialization): time 0.001237/3.007, allocations: 101 kB / 1.772 GB, free: 4.418 MB / 1.357 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004651/3.012, allocations: 3.323 MB / 1.776 GB, free: 1.086 MB / 1.357 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001794/3.014, allocations: 0.9624 MB / 1.777 GB, free: 136 kB / 1.357 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003767/3.018, allocations: 1.002 MB / 1.777 GB, free: 15.12 MB / 1.373 GB
Notification: Performance of setup shared object (initialization): time 9.219e-05/3.018, allocations: 309.1 kB / 1.778 GB, free: 14.82 MB / 1.373 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.006586/3.024, allocations: 2.336 MB / 1.78 GB, free: 12.46 MB / 1.373 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.007917/3.032, allocations: 3.57 MB / 1.784 GB, free: 8.398 MB / 1.373 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01223/3.045, allocations: 5.452 MB / 1.789 GB, free: 2.633 MB / 1.373 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.605e-05/3.045, allocations: 8 kB / 1.789 GB, free: 2.625 MB / 1.373 GB
Notification: Performance of matching and sorting (n=610) (initialization): time 0.02401/3.069, allocations: 7.082 MB / 1.796 GB, free: 11.67 MB / 1.389 GB
Notification: Performance of prepare postOptimizeDAE: time 5.936e-05/3.069, allocations: 16 kB / 1.796 GB, free: 11.66 MB / 1.389 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.427e-05/3.069, allocations: 35.98 kB / 1.796 GB, free: 11.62 MB / 1.389 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007903/3.077, allocations: 1.17 MB / 1.797 GB, free: 10.45 MB / 1.389 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00639/3.083, allocations: 1.084 MB / 1.798 GB, free: 9.422 MB / 1.389 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007859/3.091, allocations: 4.85 MB / 1.803 GB, free: 4.285 MB / 1.389 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008874/3.1, allocations: 428.3 kB / 1.803 GB, free: 3.867 MB / 1.389 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001321/3.101, allocations: 211.9 kB / 1.803 GB, free: 3.66 MB / 1.389 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01123/3.113, allocations: 3.835 MB / 1.807 GB, free: 15.81 MB / 1.404 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.007648/3.12, allocations: 3.512 MB / 1.811 GB, free: 11.81 MB / 1.404 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01258/3.133, allocations: 5.349 MB / 1.816 GB, free: 6.148 MB / 1.404 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.005e-05/3.133, allocations: 8 kB / 1.816 GB, free: 6.141 MB / 1.404 GB
Notification: Performance of matching and sorting (n=610) (initialization_lambda0): time 0.02341/3.156, allocations: 6.961 MB / 1.823 GB, free: 15.31 MB / 1.42 GB
Notification: Performance of prepare postOptimizeDAE: time 6.374e-05/3.156, allocations: 20 kB / 1.823 GB, free: 15.29 MB / 1.42 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.551e-05/3.157, allocations: 28 kB / 1.823 GB, free: 15.26 MB / 1.42 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007741/3.164, allocations: 1.18 MB / 1.824 GB, free: 14.07 MB / 1.42 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005501/3.17, allocations: 1.073 MB / 1.825 GB, free: 13.06 MB / 1.42 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007458/3.177, allocations: 4.843 MB / 1.83 GB, free: 7.941 MB / 1.42 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008923/3.186, allocations: 456.9 kB / 1.83 GB, free: 7.496 MB / 1.42 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001264/3.188, allocations: 199.9 kB / 1.83 GB, free: 7.301 MB / 1.42 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 134
 * Number of states: 0 ()
 * Number of discrete variables: 20 (weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,booToInt.y,hysRad.y,$PRE.hysRad.y,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 (526):
 * Single equations (assignments): 519
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 2
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,6,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(4,7), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.0023/3.19, allocations: 455.9 kB / 1.831 GB, free: 6.91 MB / 1.42 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003409/3.193, allocations: 0.6596 MB / 1.831 GB, free: 6.242 MB / 1.42 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01525/3.209, allocations: 4.904 MB / 1.836 GB, free: 1.277 MB / 1.42 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.009816/3.218, allocations: 3.845 MB / 1.84 GB, free: 13.36 MB / 1.436 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.191e-05/3.218, allocations: 0 / 1.84 GB, free: 13.36 MB / 1.436 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005116/3.224, allocations: 1.234 MB / 1.841 GB, free: 12.1 MB / 1.436 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003197/3.227, allocations: 59.98 kB / 1.841 GB, free: 12.04 MB / 1.436 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.007186/3.234, allocations: 331.6 kB / 1.841 GB, free: 11.71 MB / 1.436 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0007363/3.235, allocations: 214.1 kB / 1.842 GB, free: 11.5 MB / 1.436 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01445/3.249, allocations: 4.666 MB / 1.846 GB, free: 6.832 MB / 1.436 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.02056/3.27, allocations: 6.709 MB / 1.853 GB, free: 44 kB / 1.436 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004722/3.275, allocations: 1.905 MB / 1.855 GB, free: 14.12 MB / 1.451 GB
Notification: Performance of sorting global known variables: time 0.01323/3.288, allocations: 4.526 MB / 1.859 GB, free: 9.637 MB / 1.451 GB
Notification: Performance of Backend: time 1.863e-06/3.288, allocations: 0 / 1.859 GB, free: 9.637 MB / 1.451 GB
Notification: Performance of simCode: created initialization part: time 0.03823/3.326, allocations: 9.371 MB / 1.868 GB, free: 0.8203 MB / 1.451 GB
Notification: Performance of SimCode: time 0.04618/3.372, allocations: 15.24 MB / 1.883 GB, free: 1.664 MB / 1.467 GB
Notification: Performance of Templates: time 0.3058/3.678, allocations: 161 MB / 2.04 GB, free: 2.48 MB / 1.623 GB
make -j1 -f Buildings_latest_Buildings.Examples.SimpleHouse.makefile
(rm -f Buildings_latest_Buildings.Examples.SimpleHouse.pipe ; mkfifo Buildings_latest_Buildings.Examples.SimpleHouse.pipe ; head -c 1048576 < Buildings_latest_Buildings.Examples.SimpleHouse.pipe >> ../files/Buildings_latest_Buildings.Examples.SimpleHouse.sim & ./Buildings_latest_Buildings.Examples.SimpleHouse  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Examples.SimpleHouse.pipe 2>&1)