Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors.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/IBPSA 4.0.0-master/package.mo", uses=false)
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.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(IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors")
translateModel(IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00126/0.00126, allocations: 118.4 kB / 17.1 MB, free: 6.008 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.001294/0.001294, allocations: 189.6 kB / 18.02 MB, free: 5.094 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.23/1.23, allocations: 222.9 MB / 241.7 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.6769/0.6769, allocations: 115.3 MB / 407.2 MB, free: 6.176 MB / 318.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001137/0.001137, allocations: 63.88 kB / 0.5583 GB, free: 32.22 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1152/0.1163, allocations: 76.19 MB / 0.6327 GB, free: 4.445 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors): time 2.899/3.016, allocations: 1.345 GB / 1.978 GB, free: 108 kB / 1.186 GB
Notification: Performance of NFInst.instExpressions: time 0.1545/3.17, allocations: 147.6 MB / 2.122 GB, free: 0.9844 MB / 1.201 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02457/3.195, allocations: 0.5029 MB / 2.123 GB, free: 0.9844 MB / 1.201 GB
Notification: Performance of NFTyping.typeComponents: time 0.03476/3.23, allocations: 15.43 MB / 2.138 GB, free: 9.855 MB / 1.217 GB
Notification: Performance of NFTyping.typeBindings: time 0.1069/3.337, allocations: 46.4 MB / 2.183 GB, free: 9.441 MB / 1.248 GB
Notification: Performance of NFTyping.typeClassSections: time 0.05096/3.388, allocations: 21.63 MB / 2.204 GB, free: 5.945 MB / 1.264 GB
Notification: Performance of NFFlatten.flatten: time 0.0757/3.463, allocations: 65.73 MB / 2.268 GB, free: 6.52 MB / 1.326 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04644/3.51, allocations: 30.28 MB / 2.298 GB, free: 8.504 MB / 1.357 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04907/3.559, allocations: 25.4 MB / 2.323 GB, free: 444 kB / 1.373 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03935/3.598, allocations: 23.74 MB / 2.346 GB, free: 10.43 MB / 1.404 GB
Notification: Performance of NFPackage.collectConstants: time 0.01232/3.611, allocations: 3.949 MB / 2.35 GB, free: 6.484 MB / 1.404 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.07964/3.69, allocations: 41.97 MB / 2.391 GB, free: 1.758 MB / 1.436 GB
Notification: Performance of NFScalarize.scalarize: time 0.01755/3.708, allocations: 12.46 MB / 2.403 GB, free: 5.406 MB / 1.451 GB
Notification: Performance of NFVerifyModel.verify: time 0.03489/3.743, allocations: 18.57 MB / 2.421 GB, free: 2.898 MB / 1.467 GB
Notification: Performance of NFConvertDAE.convert: time 1.552/5.294, allocations: 65.7 MB / 2.485 GB, free: 135.1 MB / 1.483 GB
Notification: Performance of FrontEnd - DAE generated: time 6.432e-06/5.294, allocations: 0 / 2.485 GB, free: 135.1 MB / 1.483 GB
Notification: Performance of FrontEnd: time 1.674e-06/5.294, allocations: 0 / 2.485 GB, free: 135.1 MB / 1.483 GB
Notification: Performance of Transformations before backend: time 0.001485/5.296, allocations: 0.5312 kB / 2.485 GB, free: 135.1 MB / 1.483 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 6766
 * Number of variables: 6766
Notification: Performance of Generate backend data structure: time 0.1196/5.416, allocations: 33.81 MB / 2.518 GB, free: 123.9 MB / 1.483 GB
Notification: Performance of prepare preOptimizeDAE: time 4.306e-05/5.416, allocations: 10.14 kB / 2.518 GB, free: 123.9 MB / 1.483 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05049/5.466, allocations: 6.745 MB / 2.525 GB, free: 122.4 MB / 1.483 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0372/5.503, allocations: 16.29 MB / 2.541 GB, free: 119.5 MB / 1.483 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001717/5.505, allocations: 1.911 MB / 2.543 GB, free: 119.5 MB / 1.483 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01078/5.516, allocations: 2.526 MB / 2.545 GB, free: 119.5 MB / 1.483 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.08798/5.604, allocations: 33.2 MB / 2.578 GB, free: 117.3 MB / 1.483 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0009522/5.605, allocations: 53.75 kB / 2.578 GB, free: 117.3 MB / 1.483 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00811/5.613, allocations: 1.057 MB / 2.579 GB, free: 117.3 MB / 1.483 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001083/5.614, allocations: 1.262 MB / 2.58 GB, free: 117.3 MB / 1.483 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.06983/5.684, allocations: 34.9 MB / 2.614 GB, free: 117 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.1837/5.868, allocations: 129.5 MB / 2.74 GB, free: 35.21 MB / 1.483 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.04172/5.909, allocations: 37.94 MB / 2.778 GB, free: 13.41 MB / 1.498 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.03097/5.94, allocations: 16.5 MB / 2.794 GB, free: 12.91 MB / 1.514 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.004162/5.945, allocations: 3.087 MB / 2.797 GB, free: 9.348 MB / 1.514 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02717/5.972, allocations: 14.19 MB / 2.811 GB, free: 11.09 MB / 1.529 GB
Notification: Performance of pre-optimization done (n=2338): time 2.842e-05/5.972, allocations: 0 / 2.811 GB, free: 11.09 MB / 1.529 GB
Notification: Performance of matching and sorting (n=2338): time 0.08162/6.053, allocations: 38.73 MB / 2.848 GB, free: 3.809 MB / 1.561 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002906/6.054, allocations: 0.5434 MB / 2.849 GB, free: 3.191 MB / 1.561 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01876/6.073, allocations: 11.17 MB / 2.86 GB, free: 8.102 MB / 1.576 GB
Notification: Performance of collectPreVariables (initialization): time 0.004742/6.077, allocations: 433.7 kB / 2.86 GB, free: 7.672 MB / 1.576 GB
Notification: Performance of collectInitialEqns (initialization): time 0.008888/6.086, allocations: 9.35 MB / 2.869 GB, free: 14.25 MB / 1.592 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01153/6.098, allocations: 7.887 MB / 2.877 GB, free: 6.434 MB / 1.592 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.009321/6.107, allocations: 3.268 MB / 2.88 GB, free: 3.148 MB / 1.592 GB
Notification: Performance of setup shared object (initialization): time 8.602e-05/6.107, allocations: 301.1 kB / 2.881 GB, free: 2.852 MB / 1.592 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01779/6.125, allocations: 9.984 MB / 2.89 GB, free: 8.855 MB / 1.608 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02014/6.145, allocations: 12.13 MB / 2.902 GB, free: 12.32 MB / 1.623 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04438/6.19, allocations: 23.92 MB / 2.925 GB, free: 4.09 MB / 1.639 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.107e-05/6.19, allocations: 8 kB / 2.925 GB, free: 4.082 MB / 1.639 GB
Notification: Performance of matching and sorting (n=2567) (initialization): time 0.05965/6.249, allocations: 26.42 MB / 2.951 GB, free: 9.777 MB / 1.67 GB
Notification: Performance of prepare postOptimizeDAE: time 7.477e-05/6.249, allocations: 20.36 kB / 2.951 GB, free: 9.758 MB / 1.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.161e-05/6.249, allocations: 32 kB / 2.951 GB, free: 9.727 MB / 1.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001407/6.251, allocations: 424.2 kB / 2.952 GB, free: 9.289 MB / 1.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02198/6.273, allocations: 4.304 MB / 2.956 GB, free: 5.223 MB / 1.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01131/6.284, allocations: 16.53 MB / 2.972 GB, free: 3.426 MB / 1.686 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02147/6.306, allocations: 1.58 MB / 2.974 GB, free: 1.828 MB / 1.686 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004543/6.31, allocations: 0.6846 MB / 2.974 GB, free: 1.145 MB / 1.686 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 130
 * Number of states: 0 ()
 * Number of discrete variables: 17 (weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,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 (2549):
 * Single equations (assignments): 2535
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 5
 * Torn equation systems: 9
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 5 systems
   {1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 8 systems
   {(1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.01928/6.33, allocations: 5.64 MB / 2.98 GB, free: 11.74 MB / 1.701 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.008214/6.338, allocations: 1.779 MB / 2.982 GB, free: 9.938 MB / 1.701 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05933/6.397, allocations: 28.67 MB / 3.01 GB, free: 13.16 MB / 1.733 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04143/6.439, allocations: 24.26 MB / 3.033 GB, free: 4.781 MB / 1.748 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.035e-05/6.439, allocations: 1.422 kB / 3.033 GB, free: 4.781 MB / 1.748 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01325/6.452, allocations: 5.05 MB / 3.038 GB, free: 15.68 MB / 1.764 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003982/6.456, allocations: 424 kB / 3.039 GB, free: 15.27 MB / 1.764 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01395/6.47, allocations: 0.5424 MB / 3.039 GB, free: 14.74 MB / 1.764 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003152/6.473, allocations: 1.399 MB / 3.04 GB, free: 13.34 MB / 1.764 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.4046/6.878, allocations: 28.48 MB / 3.068 GB, free: 1.072 GB / 1.764 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.06313/6.941, allocations: 42.43 MB / 3.11 GB, free: 1.071 GB / 1.764 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01755/6.958, allocations: 13.07 MB / 3.122 GB, free: 1.066 GB / 1.764 GB
Notification: Performance of sorting global known variables: time 0.0112/6.97, allocations: 7.564 MB / 3.13 GB, free: 1.063 GB / 1.764 GB
Notification: Performance of Backend: time 7.81e-07/6.97, allocations: 0 / 3.13 GB, free: 1.063 GB / 1.764 GB
Notification: Performance of simCode: created initialization part: time 0.05547/7.025, allocations: 24.57 MB / 3.154 GB, free: 1.056 GB / 1.764 GB
Notification: Performance of SimCode: time 0.08469/7.11, allocations: 49.38 MB / 3.202 GB, free: 1.035 GB / 1.764 GB
Notification: Performance of Templates: time 0.5652/7.675, allocations: 0.4888 GB / 3.691 GB, free: 0.604 GB / 1.764 GB
make -j1 -f IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors.makefile
(rm -f IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors.pipe ; mkfifo IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors.pipe >> ../files/IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors.sim & ./IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors.pipe 2>&1)