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.001506/0.001506, allocations: 114.1 kB / 17.09 MB, free: 5.996 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.001762/0.001762, allocations: 190.8 kB / 18.02 MB, free: 5.082 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.32/1.32, allocations: 222.9 MB / 241.7 MB, free: 15.18 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.7501/0.7501, allocations: 122.8 MB / 414.7 MB, free: 15.84 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.002175/0.002175, allocations: 63.34 kB / 0.5691 GB, free: 28.87 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1349/0.1371, allocations: 77.93 MB / 0.6452 GB, free: 9.059 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors): time 3.179/3.316, allocations: 1.345 GB / 1.991 GB, free: 96 kB / 1.201 GB
Notification: Performance of NFInst.instExpressions: time 0.1772/3.493, allocations: 147.6 MB / 2.135 GB, free: 2.746 MB / 1.217 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02843/3.521, allocations: 0.5018 MB / 2.135 GB, free: 2.746 MB / 1.217 GB
Notification: Performance of NFTyping.typeComponents: time 0.03897/3.56, allocations: 16.08 MB / 2.151 GB, free: 11.3 MB / 1.232 GB
Notification: Performance of NFTyping.typeBindings: time 0.1195/3.68, allocations: 47.86 MB / 2.198 GB, free: 11.05 MB / 1.264 GB
Notification: Performance of NFTyping.typeClassSections: time 0.05533/3.735, allocations: 21.89 MB / 2.219 GB, free: 7.293 MB / 1.279 GB
Notification: Performance of NFFlatten.flatten: time 0.07889/3.814, allocations: 65.8 MB / 2.283 GB, free: 7.812 MB / 1.342 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04589/3.86, allocations: 30.27 MB / 2.313 GB, free: 9.789 MB / 1.373 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04836/3.909, allocations: 25.71 MB / 2.338 GB, free: 1.406 MB / 1.389 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0395/3.948, allocations: 23.74 MB / 2.361 GB, free: 11.41 MB / 1.42 GB
Notification: Performance of NFPackage.collectConstants: time 0.01318/3.961, allocations: 3.949 MB / 2.365 GB, free: 7.457 MB / 1.42 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.08927/4.051, allocations: 42.16 MB / 2.406 GB, free: 2.547 MB / 1.451 GB
Notification: Performance of NFScalarize.scalarize: time 0.01943/4.07, allocations: 12.46 MB / 2.418 GB, free: 6.191 MB / 1.467 GB
Notification: Performance of NFVerifyModel.verify: time 0.03877/4.109, allocations: 18.57 MB / 2.436 GB, free: 3.688 MB / 1.482 GB
Notification: Performance of NFConvertDAE.convert: time 1.674/5.783, allocations: 65.7 MB / 2.501 GB, free: 135.8 MB / 1.498 GB
Notification: Performance of FrontEnd - DAE generated: time 5.6e-06/5.783, allocations: 0.5 kB / 2.501 GB, free: 135.8 MB / 1.498 GB
Notification: Performance of FrontEnd: time 3.196e-06/5.783, allocations: 0.5312 kB / 2.501 GB, free: 135.8 MB / 1.498 GB
Notification: Performance of Transformations before backend: time 0.00172/5.784, allocations: 1.766 kB / 2.501 GB, free: 135.8 MB / 1.498 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.1324/5.917, allocations: 33.81 MB / 2.534 GB, free: 124.7 MB / 1.498 GB
Notification: Performance of prepare preOptimizeDAE: time 4.255e-05/5.917, allocations: 10.5 kB / 2.534 GB, free: 124.7 MB / 1.498 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05253/5.969, allocations: 6.746 MB / 2.54 GB, free: 123.1 MB / 1.498 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04285/6.012, allocations: 16.29 MB / 2.556 GB, free: 120.3 MB / 1.498 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001827/6.014, allocations: 1.904 MB / 2.558 GB, free: 120.2 MB / 1.498 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01147/6.026, allocations: 2.526 MB / 2.56 GB, free: 120.2 MB / 1.498 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.09728/6.123, allocations: 33.2 MB / 2.593 GB, free: 118.1 MB / 1.498 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001221/6.124, allocations: 53.84 kB / 2.593 GB, free: 118 MB / 1.498 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.01/6.134, allocations: 1.057 MB / 2.594 GB, free: 118 MB / 1.498 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001249/6.135, allocations: 1.259 MB / 2.595 GB, free: 118 MB / 1.498 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.07722/6.213, allocations: 34.91 MB / 2.629 GB, free: 117.7 MB / 1.498 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.2166/6.429, allocations: 129.5 MB / 2.756 GB, free: 38.75 MB / 1.498 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.04916/6.478, allocations: 37.94 MB / 2.793 GB, free: 0.9609 MB / 1.498 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.03444/6.513, allocations: 16.5 MB / 2.809 GB, free: 464 kB / 1.514 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.005124/6.518, allocations: 3.088 MB / 2.812 GB, free: 12.89 MB / 1.529 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0354/6.554, allocations: 14.19 MB / 2.826 GB, free: 14.64 MB / 1.545 GB
Notification: Performance of pre-optimization done (n=2338): time 4.136e-05/6.554, allocations: 0 / 2.826 GB, free: 14.64 MB / 1.545 GB
Notification: Performance of matching and sorting (n=2338): time 0.1038/6.657, allocations: 38.73 MB / 2.864 GB, free: 7.355 MB / 1.576 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000352/6.658, allocations: 0.5434 MB / 2.864 GB, free: 6.742 MB / 1.576 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02558/6.683, allocations: 11.17 MB / 2.875 GB, free: 11.65 MB / 1.592 GB
Notification: Performance of collectPreVariables (initialization): time 0.00537/6.689, allocations: 433.7 kB / 2.876 GB, free: 11.22 MB / 1.592 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01065/6.699, allocations: 9.343 MB / 2.885 GB, free: 1.809 MB / 1.592 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01201/6.711, allocations: 7.889 MB / 2.892 GB, free: 9.984 MB / 1.608 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01513/6.727, allocations: 3.268 MB / 2.896 GB, free: 6.699 MB / 1.608 GB
Notification: Performance of setup shared object (initialization): time 9.276e-05/6.727, allocations: 309.1 kB / 2.896 GB, free: 6.395 MB / 1.608 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0212/6.748, allocations: 9.984 MB / 2.906 GB, free: 12.4 MB / 1.623 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02536/6.773, allocations: 12.13 MB / 2.917 GB, free: 15.86 MB / 1.639 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.05154/6.825, allocations: 23.93 MB / 2.941 GB, free: 7.629 MB / 1.654 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.381e-05/6.825, allocations: 8 kB / 2.941 GB, free: 7.621 MB / 1.654 GB
Notification: Performance of matching and sorting (n=2567) (initialization): time 0.07314/6.898, allocations: 26.41 MB / 2.967 GB, free: 13.33 MB / 1.686 GB
Notification: Performance of prepare postOptimizeDAE: time 6.916e-05/6.898, allocations: 23.92 kB / 2.967 GB, free: 13.3 MB / 1.686 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.751e-05/6.898, allocations: 28.38 kB / 2.967 GB, free: 13.28 MB / 1.686 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001443/6.9, allocations: 427.9 kB / 2.967 GB, free: 12.84 MB / 1.686 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02528/6.925, allocations: 4.309 MB / 2.971 GB, free: 8.766 MB / 1.686 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01248/6.938, allocations: 16.52 MB / 2.987 GB, free: 6.977 MB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02355/6.961, allocations: 1.581 MB / 2.989 GB, free: 5.379 MB / 1.701 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005654/6.967, allocations: 0.6913 MB / 2.99 GB, free: 4.688 MB / 1.701 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.02326/6.99, allocations: 5.639 MB / 2.995 GB, free: 15.28 MB / 1.717 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01009/7, allocations: 1.777 MB / 2.997 GB, free: 13.48 MB / 1.717 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0846/7.085, allocations: 28.68 MB / 3.025 GB, free: 0.7031 MB / 1.733 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.06086/7.146, allocations: 24.26 MB / 3.049 GB, free: 8.324 MB / 1.764 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.712e-05/7.146, allocations: 3.016 kB / 3.049 GB, free: 8.324 MB / 1.764 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01738/7.163, allocations: 5.046 MB / 3.053 GB, free: 3.23 MB / 1.764 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.00928/7.172, allocations: 416 kB / 3.054 GB, free: 2.824 MB / 1.764 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02161/7.194, allocations: 0.5455 MB / 3.054 GB, free: 2.289 MB / 1.764 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.006911/7.201, allocations: 1.406 MB / 3.056 GB, free: 0.8789 MB / 1.764 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.4857/7.687, allocations: 28.47 MB / 3.084 GB, free: 1.078 GB / 1.779 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.09391/7.781, allocations: 42.44 MB / 3.125 GB, free: 1.077 GB / 1.779 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.02251/7.803, allocations: 13.07 MB / 3.138 GB, free: 1.073 GB / 1.779 GB
Notification: Performance of sorting global known variables: time 0.01596/7.819, allocations: 7.569 MB / 3.145 GB, free: 1.07 GB / 1.779 GB
Notification: Performance of Backend: time 1.012e-06/7.819, allocations: 0 / 3.145 GB, free: 1.07 GB / 1.779 GB
Notification: Performance of simCode: created initialization part: time 0.07475/7.894, allocations: 24.57 MB / 3.169 GB, free: 1.063 GB / 1.779 GB
Notification: Performance of SimCode: time 0.1068/8.001, allocations: 49.36 MB / 3.217 GB, free: 1.042 GB / 1.779 GB
Notification: Performance of Templates: time 0.626/8.627, allocations: 0.4888 GB / 3.706 GB, free: 0.6144 GB / 1.779 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)