Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements.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/IDEAS 3.0.0-master/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.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: translateModel(IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements,tolerance=1e-06,outputFormat="empty",numberOfIntervals=17520,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements")
translateModel(IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements,tolerance=1e-06,outputFormat="empty",numberOfIntervals=17520,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001023/0.001023, allocations: 91.84 kB / 15.36 MB, free: 0.7383 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.008169/0.00817, allocations: 169.8 kB / 16.26 MB, free: 6.676 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.416/1.416, allocations: 223.3 MB / 240.3 MB, free: 5.324 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.991/0.991, allocations: 135.3 MB / 426.7 MB, free: 14.24 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003609/0.0003607, allocations: 8.781 kB / 0.5076 GB, free: 4.75 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2036/0.2039, allocations: 82.31 MB / 0.588 GB, free: 2.617 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements): time 0.5785/0.7825, allocations: 157.1 MB / 0.7414 GB, free: 9.656 MB / 0.5606 GB
Notification: Performance of NFInst.instExpressions: time 0.03993/0.8224, allocations: 26.58 MB / 0.7673 GB, free: 4.066 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005353/0.8278, allocations: 67.62 kB / 0.7674 GB, free: 4 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.003089/0.831, allocations: 0.9411 MB / 0.7683 GB, free: 3.055 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.008198/0.8392, allocations: 1.587 MB / 0.7699 GB, free: 1.465 MB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005037/0.8442, allocations: 1.585 MB / 0.7714 GB, free: 15.9 MB / 0.5919 GB
Notification: Performance of NFFlatten.flatten: time 0.007885/0.8521, allocations: 5.46 MB / 0.7768 GB, free: 10.43 MB / 0.5919 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.007804/0.86, allocations: 3.686 MB / 0.7804 GB, free: 6.68 MB / 0.5919 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004409/0.8644, allocations: 1.443 MB / 0.7818 GB, free: 5.23 MB / 0.5919 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.005229/0.8697, allocations: 2.036 MB / 0.7838 GB, free: 3.188 MB / 0.5919 GB
Notification: Performance of NFPackage.collectConstants: time 0.0008917/0.8706, allocations: 120 kB / 0.7839 GB, free: 3.07 MB / 0.5919 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003261/0.8739, allocations: 0.7217 MB / 0.7846 GB, free: 2.348 MB / 0.5919 GB
Notification: Performance of NFScalarize.scalarize: time 0.001213/0.8751, allocations: 0.7895 MB / 0.7853 GB, free: 1.555 MB / 0.5919 GB
Notification: Performance of NFVerifyModel.verify: time 0.003447/0.8786, allocations: 1.683 MB / 0.787 GB, free: 15.85 MB / 0.6075 GB
Notification: Performance of NFConvertDAE.convert: time 0.01012/0.8887, allocations: 5.688 MB / 0.7925 GB, free: 10.15 MB / 0.6075 GB
Notification: Performance of FrontEnd - DAE generated: time 6.351e-06/0.8888, allocations: 0 / 0.7925 GB, free: 10.15 MB / 0.6075 GB
Notification: Performance of FrontEnd: time 4.338e-06/0.8888, allocations: 0 / 0.7925 GB, free: 10.15 MB / 0.6075 GB
Notification: Performance of Transformations before backend: time 0.0002122/0.889, allocations: 0 / 0.7925 GB, free: 10.15 MB / 0.6075 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 882
 * Number of variables: 882
Notification: Performance of Generate backend data structure: time 0.0144/0.9034, allocations: 4.028 MB / 0.7965 GB, free: 6.055 MB / 0.6075 GB
Notification: Performance of prepare preOptimizeDAE: time 5.816e-05/0.9035, allocations: 8.031 kB / 0.7965 GB, free: 6.047 MB / 0.6075 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02152/0.925, allocations: 2.916 MB / 0.7993 GB, free: 3.121 MB / 0.6075 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01041/0.9355, allocations: 2.373 MB / 0.8017 GB, free: 0.6719 MB / 0.6075 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005751/0.9362, allocations: 254.9 kB / 0.8019 GB, free: 432 kB / 0.6075 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00291/0.9391, allocations: 336 kB / 0.8022 GB, free: 96 kB / 0.6075 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02103/0.9601, allocations: 5.428 MB / 0.8075 GB, free: 10.59 MB / 0.6231 GB
Notification: Performance of preOpt findStateOrder (simulation): time 9.886e-05/0.9603, allocations: 7.891 kB / 0.8075 GB, free: 10.58 MB / 0.6231 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005959/0.9609, allocations: 147.9 kB / 0.8077 GB, free: 10.44 MB / 0.6231 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.563e-05/0.961, allocations: 80 kB / 0.8077 GB, free: 10.36 MB / 0.6231 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0248/0.9858, allocations: 6.617 MB / 0.8142 GB, free: 3.73 MB / 0.6231 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.03023/1.016, allocations: 15.75 MB / 0.8296 GB, free: 3.375 MB / 0.6387 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.008639/1.025, allocations: 4.1 MB / 0.8336 GB, free: 15.26 MB / 0.6544 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005341/1.03, allocations: 2.659 MB / 0.8362 GB, free: 12.59 MB / 0.6544 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0009423/1.031, allocations: 0.6736 MB / 0.8368 GB, free: 11.79 MB / 0.6544 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.005482/1.037, allocations: 2.579 MB / 0.8394 GB, free: 9.176 MB / 0.6544 GB
Notification: Performance of pre-optimization done (n=288): time 5.891e-06/1.037, allocations: 0 / 0.8394 GB, free: 9.176 MB / 0.6544 GB
Notification: Performance of matching and sorting (n=288): time 0.02151/1.058, allocations: 8.443 MB / 0.8476 GB, free: 0.6172 MB / 0.6544 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001466/1.058, allocations: 214.1 kB / 0.8478 GB, free: 372 kB / 0.6544 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003537/1.062, allocations: 2.513 MB / 0.8503 GB, free: 13.82 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.0005509/1.062, allocations: 73.7 kB / 0.8503 GB, free: 13.75 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001307/1.064, allocations: 1.431 MB / 0.8517 GB, free: 12.3 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001165/1.065, allocations: 0.9588 MB / 0.8527 GB, free: 11.33 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003627/1.065, allocations: 210.9 kB / 0.8529 GB, free: 11.12 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 0.0001056/1.065, allocations: 301.1 kB / 0.8532 GB, free: 10.82 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004852/1.07, allocations: 2.07 MB / 0.8552 GB, free: 8.746 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005099/1.075, allocations: 2.376 MB / 0.8575 GB, free: 6.297 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01007/1.085, allocations: 4.446 MB / 0.8618 GB, free: 1.766 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.238e-05/1.085, allocations: 4 kB / 0.8618 GB, free: 1.762 MB / 0.67 GB
Notification: Performance of matching and sorting (n=327) (initialization): time 0.3652/1.451, allocations: 5.333 MB / 0.867 GB, free: 212.5 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 2.893e-05/1.451, allocations: 5.969 kB / 0.8671 GB, free: 212.5 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.642e-05/1.451, allocations: 2.969 kB / 0.8671 GB, free: 212.5 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001159/1.452, allocations: 0.5378 MB / 0.8676 GB, free: 212.5 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003899/1.456, allocations: 0.7978 MB / 0.8684 GB, free: 212.5 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006655/1.463, allocations: 5.282 MB / 0.8735 GB, free: 211 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004171/1.467, allocations: 0.5796 MB / 0.8741 GB, free: 211 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003999/1.467, allocations: 112 kB / 0.8742 GB, free: 210.9 MB / 0.67 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 17
 * Number of states: 0 ()
 * Number of discrete variables: 13 ($PRE.intGai.nextTimeEvent,$whenCondition1,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,intGai.nextTimeEventScaled,$PRE.intGai.nextTimeEventScaled,intGai.nextTimeEvent,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,$whenCondition2,$whenCondition3)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (282):
 * Single equations (assignments): 281
 * 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): 1 system
   {(4,42,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.002133/1.469, allocations: 0.9748 MB / 0.8751 GB, free: 210.5 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006214/1.47, allocations: 287.5 kB / 0.8754 GB, free: 210.4 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01215/1.482, allocations: 5.898 MB / 0.8812 GB, free: 208.5 MB / 0.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.294e-05/1.482, allocations: 28.19 kB / 0.8812 GB, free: 208.5 MB / 0.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.176e-05/1.482, allocations: 8.047 kB / 0.8812 GB, free: 208.5 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.526e-05/1.482, allocations: 22.38 kB / 0.8812 GB, free: 208.5 MB / 0.67 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01715/1.499, allocations: 9.908 MB / 0.8909 GB, free: 204.9 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.02e-05/1.499, allocations: 0 / 0.8909 GB, free: 204.9 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003523/1.503, allocations: 0.7505 MB / 0.8916 GB, free: 204.9 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.00152/1.504, allocations: 0.5237 MB / 0.8922 GB, free: 204.8 MB / 0.67 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002822/1.505, allocations: 81.14 kB / 0.8922 GB, free: 204.7 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007922/1.513, allocations: 6.954 MB / 0.899 GB, free: 199.7 MB / 0.67 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.663e-06/1.513, allocations: 1.344 kB / 0.899 GB, free: 199.7 MB / 0.67 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02042/1.533, allocations: 8.417 MB / 0.9072 GB, free: 196.8 MB / 0.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002869/1.536, allocations: 0.8811 MB / 0.9081 GB, free: 196.3 MB / 0.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005126/1.537, allocations: 55.34 kB / 0.9082 GB, free: 196.3 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003209/1.54, allocations: 441.2 kB / 0.9086 GB, free: 196.2 MB / 0.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005942/1.54, allocations: 185.9 kB / 0.9088 GB, free: 196.2 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002561/1.541, allocations: 104.4 kB / 0.9089 GB, free: 196.2 MB / 0.67 GB
Notification: Performance of sorting global known variables: time 0.002834/1.544, allocations: 1.828 MB / 0.9106 GB, free: 195.5 MB / 0.67 GB
Notification: Performance of sort global known variables: time 4.91e-07/1.544, allocations: 0 / 0.9106 GB, free: 195.5 MB / 0.67 GB
Notification: Performance of remove unused functions: time 0.003486/1.547, allocations: 1.108 MB / 0.9117 GB, free: 195.3 MB / 0.67 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 5 (thermalZoneThreeElements.volAir.dynBal.U,thermalZoneThreeElements.volAir.dynBal.m,thermalZoneThreeElements.extWallRC.thermCapExt[1].T,thermalZoneThreeElements.intWallRC.thermCapInt[1].T,thermalZoneThreeElements.floorRC.thermCapExt[1].T)
 * Number of discrete variables: 7 ($whenCondition3,$whenCondition2,$whenCondition1,weaDat.conTimMin.tNext,weaDat.conTim.tNext,intGai.nextTimeEvent,intGai.nextTimeEventScaled)
 * Number of discrete states: 4 (intGai.nextTimeEvent,intGai.nextTimeEventScaled,weaDat.conTimMin.tNext,weaDat.conTim.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (260):
 * Single equations (assignments): 253
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 4
 * 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): 2 systems
   {(4,36,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.002548/1.55, allocations: 1.039 MB / 0.9127 GB, free: 195 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.01246/1.562, allocations: 5.109 MB / 0.9177 GB, free: 193.4 MB / 0.67 GB
Notification: Performance of simCode: created event and clocks part: time 5.61e-06/1.562, allocations: 1.062 kB / 0.9177 GB, free: 193.4 MB / 0.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.006821/1.569, allocations: 2.957 MB / 0.9206 GB, free: 192.3 MB / 0.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003866/1.573, allocations: 0.6684 MB / 0.9213 GB, free: 192 MB / 0.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01651/1.589, allocations: 10.02 MB / 0.9311 GB, free: 186.9 MB / 0.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001875/1.591, allocations: 2.557 MB / 0.9335 GB, free: 185.9 MB / 0.67 GB
Notification: Performance of simCode: alias equations: time 0.004323/1.596, allocations: 1.127 MB / 0.9347 GB, free: 185.7 MB / 0.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001068/1.597, allocations: 267.4 kB / 0.9349 GB, free: 185.7 MB / 0.67 GB
Notification: Performance of SimCode: time 9.91e-07/1.597, allocations: 0 / 0.9349 GB, free: 185.7 MB / 0.67 GB
Notification: Performance of Templates: time 0.07044/1.667, allocations: 47.15 MB / 0.9809 GB, free: 142.2 MB / 0.67 GB
make -j1 -f IDEAS_dev_IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements.makefile
(rm -f IDEAS_dev_IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements.pipe ; mkfifo IDEAS_dev_IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements.pipe >> ../files/IDEAS_dev_IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements.sim & ./IDEAS_dev_IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.ThermalZones.ReducedOrder.Examples.SimpleRoomThreeElements.pipe 2>&1)