Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.OneOpenDoor.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 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo", uses=false)
Using package Annex60 with version 1.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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(Annex60.Airflow.Multizone.Examples.OneOpenDoor,tolerance=1e-05,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.OneOpenDoor")
translateModel(Annex60.Airflow.Multizone.Examples.OneOpenDoor,tolerance=1e-05,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.OneOpenDoor")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001009/0.001009, allocations: 111.3 kB / 15.23 MB, free: 0.6602 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.001121/0.001121, allocations: 193.8 kB / 16.13 MB, free: 6.66 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.38/1.38, allocations: 205.1 MB / 222 MB, free: 4.73 MB / 174.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo): time 0.3891/0.3891, allocations: 54.92 MB / 324.3 MB, free: 116 kB / 254.1 MB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Annex60 requested package Modelica of version 3.2.2. Modelica 3.2.3 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.001498/0.001498, allocations: 67.91 kB / 394.7 MB, free: 12.24 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1332/0.1348, allocations: 59.59 MB / 454.3 MB, free: 0.5898 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(Annex60.Airflow.Multizone.Examples.OneOpenDoor): time 0.4145/0.5493, allocations: 164.3 MB / 0.6041 GB, free: 3.598 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01287/0.5622, allocations: 8.311 MB / 0.6122 GB, free: 11.28 MB / 494.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001786/0.564, allocations: 35.75 kB / 0.6122 GB, free: 11.24 MB / 494.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001545/0.5656, allocations: 485.5 kB / 0.6127 GB, free: 10.77 MB / 494.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.004225/0.5699, allocations: 1.404 MB / 0.614 GB, free: 9.355 MB / 494.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002697/0.5726, allocations: 0.8749 MB / 0.6149 GB, free: 8.484 MB / 494.1 MB
Notification: Performance of NFFlatten.flatten: time 0.005824/0.5784, allocations: 5.437 MB / 0.6202 GB, free: 3.035 MB / 494.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.00157/0.58, allocations: 1.138 MB / 0.6213 GB, free: 1.879 MB / 494.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.00264/0.5827, allocations: 1.339 MB / 0.6226 GB, free: 0.5352 MB / 494.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002306/0.585, allocations: 1.558 MB / 0.6241 GB, free: 14.97 MB / 0.4981 GB
Notification: Performance of NFPackage.collectConstants: time 0.000264/0.5853, allocations: 100 kB / 0.6242 GB, free: 14.88 MB / 0.4981 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002786/0.5881, allocations: 1.099 MB / 0.6253 GB, free: 13.77 MB / 0.4981 GB
Notification: Performance of NFScalarize.scalarize: time 0.0005219/0.5886, allocations: 0.5101 MB / 0.6258 GB, free: 13.26 MB / 0.4981 GB
Notification: Performance of NFVerifyModel.verify: time 0.001137/0.5897, allocations: 0.8594 MB / 0.6266 GB, free: 12.4 MB / 0.4981 GB
Notification: Performance of NFConvertDAE.convert: time 0.003159/0.5929, allocations: 2.567 MB / 0.6292 GB, free: 9.824 MB / 0.4981 GB
Notification: Performance of FrontEnd - DAE generated: time 4.729e-06/0.5929, allocations: 0 / 0.6292 GB, free: 9.824 MB / 0.4981 GB
Notification: Performance of FrontEnd: time 1.242e-06/0.5929, allocations: 0.9375 kB / 0.6292 GB, free: 9.824 MB / 0.4981 GB
Notification: Performance of Transformations before backend: time 2.283e-05/0.593, allocations: 0 / 0.6292 GB, free: 9.824 MB / 0.4981 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 355
 * Number of variables: 355
Notification: Performance of Generate backend data structure: time 0.004598/0.5976, allocations: 2.128 MB / 0.6312 GB, free: 7.645 MB / 0.4981 GB
Notification: Performance of prepare preOptimizeDAE: time 5.257e-05/0.5976, allocations: 8.031 kB / 0.6312 GB, free: 7.637 MB / 0.4981 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004588/0.5981, allocations: 175 kB / 0.6314 GB, free: 7.465 MB / 0.4981 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001529/0.5996, allocations: 0.9742 MB / 0.6324 GB, free: 6.449 MB / 0.4981 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.272e-05/0.5997, allocations: 104 kB / 0.6325 GB, free: 6.348 MB / 0.4981 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002176/0.5999, allocations: 141.2 kB / 0.6326 GB, free: 6.211 MB / 0.4981 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002906/0.6029, allocations: 1.837 MB / 0.6344 GB, free: 4.332 MB / 0.4981 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.388e-05/0.6029, allocations: 7.906 kB / 0.6344 GB, free: 4.324 MB / 0.4981 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001496/0.6031, allocations: 56 kB / 0.6344 GB, free: 4.27 MB / 0.4981 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.583e-05/0.6031, allocations: 32 kB / 0.6345 GB, free: 4.238 MB / 0.4981 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003605/0.6067, allocations: 2.251 MB / 0.6367 GB, free: 1.98 MB / 0.4981 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.243/0.8497, allocations: 5.887 MB / 0.6424 GB, free: 158.2 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003908/0.8536, allocations: 2.622 MB / 0.645 GB, free: 158.1 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001725/0.8554, allocations: 1.351 MB / 0.6463 GB, free: 157.7 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001176/0.8566, allocations: 1.644 MB / 0.6479 GB, free: 155.9 MB / 0.4981 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.761e-05/0.8566, allocations: 60.16 kB / 0.648 GB, free: 155.9 MB / 0.4981 GB
Notification: Performance of pre-optimization done (n=215): time 3.998e-06/0.8566, allocations: 0 / 0.648 GB, free: 155.9 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=215): time 0.004762/0.8614, allocations: 3.197 MB / 0.6511 GB, free: 154.6 MB / 0.4981 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.844e-05/0.8615, allocations: 78.97 kB / 0.6512 GB, free: 154.5 MB / 0.4981 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0006274/0.8621, allocations: 0.5576 MB / 0.6517 GB, free: 154.3 MB / 0.4981 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001162/0.8622, allocations: 61.14 kB / 0.6518 GB, free: 154.2 MB / 0.4981 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002351/0.8625, allocations: 426.4 kB / 0.6522 GB, free: 153.9 MB / 0.4981 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0004412/0.8629, allocations: 0.7175 MB / 0.6529 GB, free: 153.4 MB / 0.4981 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004573/0.8634, allocations: 328 kB / 0.6532 GB, free: 153.2 MB / 0.4981 GB
Notification: Performance of setup shared object (initialization): time 7.845e-05/0.8635, allocations: 351.8 kB / 0.6535 GB, free: 152.9 MB / 0.4981 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001235/0.8647, allocations: 0.8476 MB / 0.6544 GB, free: 152.6 MB / 0.4981 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001385/0.8661, allocations: 1.052 MB / 0.6554 GB, free: 152.1 MB / 0.4981 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002778/0.8689, allocations: 2.087 MB / 0.6574 GB, free: 151.2 MB / 0.4981 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.239e-06/0.8689, allocations: 0 / 0.6574 GB, free: 151.2 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=238) (initialization): time 0.003399/0.8723, allocations: 2.289 MB / 0.6597 GB, free: 150.3 MB / 0.4981 GB
Notification: Performance of prepare postOptimizeDAE: time 2.446e-05/0.8723, allocations: 5.688 kB / 0.6597 GB, free: 150.3 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.449e-05/0.8724, allocations: 5.812 kB / 0.6597 GB, free: 150.3 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.176e-05/0.8724, allocations: 11.55 kB / 0.6597 GB, free: 150.3 MB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001748/0.8742, allocations: 408.4 kB / 0.6601 GB, free: 150.3 MB / 0.4981 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.277e-05/0.8742, allocations: 15.98 kB / 0.6601 GB, free: 150.3 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001226/0.8754, allocations: 186.5 kB / 0.6603 GB, free: 150.2 MB / 0.4981 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000139/0.8756, allocations: 73.02 kB / 0.6603 GB, free: 150.2 MB / 0.4981 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 15
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (238):
 * Single equations (assignments): 238
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0006741/0.8763, allocations: 390 kB / 0.6607 GB, free: 150 MB / 0.4981 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002435/0.8765, allocations: 128.2 kB / 0.6608 GB, free: 149.9 MB / 0.4981 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004779/0.8813, allocations: 2.747 MB / 0.6635 GB, free: 148.8 MB / 0.4981 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.873e-05/0.8813, allocations: 28.16 kB / 0.6635 GB, free: 148.8 MB / 0.4981 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 9.848e-06/0.8814, allocations: 0.6094 kB / 0.6635 GB, free: 148.8 MB / 0.4981 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003562/0.8849, allocations: 2.371 MB / 0.6658 GB, free: 147.8 MB / 0.4981 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.005934/0.8909, allocations: 4.198 MB / 0.6699 GB, free: 146 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.738e-06/0.8909, allocations: 0.625 kB / 0.6699 GB, free: 146 MB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001751/0.8926, allocations: 412.2 kB / 0.6703 GB, free: 146 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0004128/0.8931, allocations: 107.7 kB / 0.6704 GB, free: 146 MB / 0.4981 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001556/0.8932, allocations: 54.23 kB / 0.6705 GB, free: 146 MB / 0.4981 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0006664/0.8939, allocations: 1.184 MB / 0.6716 GB, free: 144.9 MB / 0.4981 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.667e-06/0.8939, allocations: 1.094 kB / 0.6717 GB, free: 144.9 MB / 0.4981 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005526/0.8995, allocations: 3.993 MB / 0.6755 GB, free: 143.2 MB / 0.4981 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007494/0.9002, allocations: 467.4 kB / 0.676 GB, free: 142.9 MB / 0.4981 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001955/0.9004, allocations: 37.19 kB / 0.676 GB, free: 142.9 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000977/0.9014, allocations: 109.9 kB / 0.6761 GB, free: 142.9 MB / 0.4981 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000278/0.9017, allocations: 139.8 kB / 0.6763 GB, free: 142.9 MB / 0.4981 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001385/0.9018, allocations: 70.34 kB / 0.6763 GB, free: 142.8 MB / 0.4981 GB
Notification: Performance of sorting global known variables: time 0.0004255/0.9023, allocations: 400.6 kB / 0.6767 GB, free: 142.6 MB / 0.4981 GB
Notification: Performance of sort global known variables: time 1.5e-07/0.9023, allocations: 1.875 kB / 0.6767 GB, free: 142.6 MB / 0.4981 GB
Notification: Performance of remove unused functions: time 0.001362/0.9036, allocations: 0.6342 MB / 0.6773 GB, free: 142.5 MB / 0.4981 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 2
 * Number of states: 8 (dooOpe.mExcAB,dooOpe.mExcBA,volA.dynBal.U,volA.dynBal.m,volB.dynBal.U,volB.dynBal.m,dooOpeClo.mExcAB,dooOpeClo.mExcBA)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (237):
 * Single equations (assignments): 235
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * 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): 2 systems
   {(2,2), (2,2)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0006596/0.9043, allocations: 403.5 kB / 0.6777 GB, free: 142.4 MB / 0.4981 GB
Notification: Performance of simCode: created initialization part: time 0.003386/0.9077, allocations: 2.247 MB / 0.6799 GB, free: 141.7 MB / 0.4981 GB
Notification: Performance of simCode: created event and clocks part: time 3.957e-06/0.9077, allocations: 2.062 kB / 0.6799 GB, free: 141.7 MB / 0.4981 GB
Notification: Performance of simCode: created simulation system equations: time 0.002085/0.9098, allocations: 1.298 MB / 0.6812 GB, free: 141.3 MB / 0.4981 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002218/0.912, allocations: 0.5305 MB / 0.6817 GB, free: 141.2 MB / 0.4981 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005277/0.9173, allocations: 4.231 MB / 0.6858 GB, free: 138.9 MB / 0.4981 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000777/0.9181, allocations: 1.277 MB / 0.6871 GB, free: 138.1 MB / 0.4981 GB
Notification: Performance of simCode: alias equations: time 0.00238/0.9205, allocations: 0.6522 MB / 0.6877 GB, free: 138 MB / 0.4981 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005981/0.9211, allocations: 157.1 kB / 0.6879 GB, free: 138 MB / 0.4981 GB
Notification: Performance of SimCode: time 7.21e-07/0.9211, allocations: 0 / 0.6879 GB, free: 138 MB / 0.4981 GB
Notification: Performance of Templates: time 0.035/0.9561, allocations: 27.35 MB / 0.7146 GB, free: 118 MB / 0.4981 GB
make -j1 -f Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.OneOpenDoor.makefile
(rm -f Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.OneOpenDoor.pipe ; mkfifo Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.OneOpenDoor.pipe ; head -c 1048576 < Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.OneOpenDoor.pipe >> ../files/Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.OneOpenDoor.sim & ./Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.OneOpenDoor  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.OneOpenDoor.pipe 2>&1)