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.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001714/0.001714, allocations: 112.7 kB / 17.12 MB, free: 6.012 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001972/0.001972, allocations: 213 kB / 20.1 MB, free: 3.059 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.571/1.571, allocations: 230.6 MB / 253.5 MB, free: 15.09 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo): time 1.023/1.023, allocations: 150 MB / 459.5 MB, free: 5.23 MB / 350.1 MB
"
[Timeout remaining time 179]
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors,fileNamePrefix="IBPSA_latest_IBPSA_Experimental_Benchmarks_AirFlow_Examples_TwoFloors",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors,fileNamePrefix="IBPSA_latest_IBPSA_Experimental_Benchmarks_AirFlow_Examples_TwoFloors",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: IBPSA requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002021/0.002021, allocations: 68.16 kB / 0.6361 GB, free: 30.45 MB / 0.4981 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1869/0.1889, allocations: 89.13 MB / 0.7232 GB, free: 4.051 MB / 0.5294 GB
Notification: Performance of NFInst.instantiate(IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors): time 3.485/3.674, allocations: 1.358 GB / 2.082 GB, free: 8.539 MB / 1.295 GB
Notification: Performance of NFInst.instExpressions: time 1.213/4.887, allocations: 148.6 MB / 2.227 GB, free: 4 kB / 1.357 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.03103/4.918, allocations: 0.6461 MB / 2.227 GB, free: 4 kB / 1.357 GB
Notification: Performance of NFTyping.typeComponents: time 0.0509/4.969, allocations: 16.21 MB / 2.243 GB, free: 15.92 MB / 1.373 GB
Notification: Performance of NFTyping.typeBindings: time 0.1352/5.104, allocations: 48.34 MB / 2.29 GB, free: 13.87 MB / 1.373 GB
Notification: Performance of NFTyping.typeClassSections: time 0.06543/5.169, allocations: 21.88 MB / 2.312 GB, free: 11.03 MB / 1.373 GB
Notification: Performance of NFFlatten.flatten: time 0.08853/5.258, allocations: 66.24 MB / 2.376 GB, free: 11.04 MB / 1.389 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.05802/5.316, allocations: 24.37 MB / 2.4 GB, free: 8.062 MB / 1.404 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.07825/5.394, allocations: 27.89 MB / 2.427 GB, free: 13.6 MB / 1.436 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.054/5.448, allocations: 24.87 MB / 2.452 GB, free: 6.441 MB / 1.451 GB
Notification: Performance of NFPackage.collectConstants: time 0.01531/5.464, allocations: 4.016 MB / 2.456 GB, free: 2.426 MB / 1.451 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.1099/5.574, allocations: 44.45 MB / 2.499 GB, free: 11.52 MB / 1.498 GB
Notification: Performance of NFScalarize.scalarize: time 0.02235/5.596, allocations: 12.57 MB / 2.511 GB, free: 15.1 MB / 1.514 GB
Notification: Performance of NFVerifyModel.verify: time 0.04846/5.644, allocations: 18.63 MB / 2.53 GB, free: 12.52 MB / 1.529 GB
Notification: Performance of NFConvertDAE.convert: time 0.1403/5.785, allocations: 66.19 MB / 2.594 GB, free: 12.75 MB / 1.592 GB
Notification: Performance of FrontEnd - DAE generated: time 4.819e-06/5.785, allocations: 0 / 2.594 GB, free: 12.75 MB / 1.592 GB
Notification: Performance of FrontEnd: time 1.473e-06/5.785, allocations: 0 / 2.594 GB, free: 12.75 MB / 1.592 GB
Notification: Performance of Transformations before backend: time 0.001523/5.786, allocations: 0 / 2.594 GB, free: 12.75 MB / 1.592 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 6976
 * Number of variables: 6976
Notification: Performance of Generate backend data structure: time 0.126/5.912, allocations: 34.44 MB / 2.628 GB, free: 10.29 MB / 1.623 GB
Notification: Performance of prepare preOptimizeDAE: time 4.659e-05/5.912, allocations: 8.031 kB / 2.628 GB, free: 10.28 MB / 1.623 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.01302/5.925, allocations: 3.478 MB / 2.631 GB, free: 6.812 MB / 1.623 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.108/6.033, allocations: 12.8 MB / 2.644 GB, free: 10.02 MB / 1.639 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04919/6.082, allocations: 16.86 MB / 2.66 GB, free: 9.289 MB / 1.654 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00283/6.085, allocations: 1.983 MB / 2.662 GB, free: 7.328 MB / 1.654 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01213/6.097, allocations: 2.521 MB / 2.665 GB, free: 4.832 MB / 1.654 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.1184/6.216, allocations: 38.81 MB / 2.702 GB, free: 13.59 MB / 1.701 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001095/6.217, allocations: 56.11 kB / 2.703 GB, free: 13.54 MB / 1.701 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.008835/6.226, allocations: 1.065 MB / 2.704 GB, free: 12.5 MB / 1.701 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.00187/6.228, allocations: 1.473 MB / 2.705 GB, free: 11.02 MB / 1.701 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1205/6.348, allocations: 43.77 MB / 2.748 GB, free: 15.21 MB / 1.748 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 1.089/7.437, allocations: 151.4 MB / 2.896 GB, free: 1.031 GB / 1.779 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.06985/7.506, allocations: 43.16 MB / 2.938 GB, free: 1.005 GB / 1.779 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0422/7.549, allocations: 18.68 MB / 2.956 GB, free: 0.9958 GB / 1.779 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.004249/7.553, allocations: 2.22 MB / 2.958 GB, free: 0.9937 GB / 1.779 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.04511/7.598, allocations: 18.54 MB / 2.976 GB, free: 0.983 GB / 1.779 GB
Notification: Performance of pre-optimization done (n=2338): time 5.441e-05/7.598, allocations: 0 / 2.976 GB, free: 0.983 GB / 1.779 GB
Notification: Performance of matching and sorting (n=2338): time 0.1294/7.727, allocations: 49 MB / 3.024 GB, free: 0.9499 GB / 1.779 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002767/7.728, allocations: 0.5455 MB / 3.025 GB, free: 0.9493 GB / 1.779 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02342/7.751, allocations: 11.49 MB / 3.036 GB, free: 0.9382 GB / 1.779 GB
Notification: Performance of collectPreVariables (initialization): time 0.006215/7.757, allocations: 425.7 kB / 3.036 GB, free: 0.9378 GB / 1.779 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01041/7.768, allocations: 9.988 MB / 3.046 GB, free: 0.9292 GB / 1.779 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01233/7.78, allocations: 8.333 MB / 3.054 GB, free: 0.9223 GB / 1.779 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01811/7.798, allocations: 3.687 MB / 3.058 GB, free: 0.9186 GB / 1.779 GB
Notification: Performance of setup shared object (initialization): time 4.905e-05/7.798, allocations: 305.1 kB / 3.058 GB, free: 0.9183 GB / 1.779 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.03048/7.829, allocations: 14.24 MB / 3.072 GB, free: 0.9045 GB / 1.779 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03362/7.862, allocations: 16.51 MB / 3.088 GB, free: 0.888 GB / 1.779 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.06674/7.929, allocations: 31.27 MB / 3.119 GB, free: 0.8571 GB / 1.779 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.469e-05/7.929, allocations: 8 kB / 3.119 GB, free: 0.8571 GB / 1.779 GB
Notification: Performance of matching and sorting (n=2769) (initialization): time 0.08767/8.017, allocations: 35.01 MB / 3.153 GB, free: 0.8229 GB / 1.779 GB
Notification: Performance of prepare postOptimizeDAE: time 6.794e-05/8.017, allocations: 16 kB / 3.153 GB, free: 0.8229 GB / 1.779 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.19e-05/8.017, allocations: 34.36 kB / 3.153 GB, free: 0.8229 GB / 1.779 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001359/8.018, allocations: 426.5 kB / 3.153 GB, free: 0.8224 GB / 1.779 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.05606/8.074, allocations: 7.323 MB / 3.16 GB, free: 0.8153 GB / 1.779 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02801/8.102, allocations: 24.31 MB / 3.184 GB, free: 0.7898 GB / 1.779 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03116/8.134, allocations: 2.441 MB / 3.187 GB, free: 0.7879 GB / 1.779 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005675/8.139, allocations: 0.7692 MB / 3.187 GB, free: 0.7871 GB / 1.779 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 130
 * Number of states: 0 ()
 * Number of discrete variables: 15 (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 (2751):
 * Single equations (assignments): 2737
 * 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.02075/8.16, allocations: 5.704 MB / 3.193 GB, free: 0.7815 GB / 1.779 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.009363/8.169, allocations: 1.88 MB / 3.195 GB, free: 0.7797 GB / 1.779 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.09462/8.264, allocations: 35.63 MB / 3.229 GB, free: 0.745 GB / 1.779 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001327/8.264, allocations: 224 kB / 3.23 GB, free: 0.7448 GB / 1.779 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.607e-05/8.264, allocations: 12 kB / 3.23 GB, free: 0.7448 GB / 1.779 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.07539/8.34, allocations: 30.91 MB / 3.26 GB, free: 0.7145 GB / 1.779 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.2089/8.548, allocations: 75.43 MB / 3.334 GB, free: 0.6416 GB / 1.779 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001132/8.549, allocations: 4 kB / 3.334 GB, free: 0.6416 GB / 1.779 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.06627/8.615, allocations: 7.961 MB / 3.341 GB, free: 0.6339 GB / 1.779 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003718/8.619, allocations: 1.182 MB / 3.342 GB, free: 0.6327 GB / 1.779 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.006706/8.625, allocations: 0.5543 MB / 3.343 GB, free: 0.6322 GB / 1.779 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.04293/8.668, allocations: 52.13 MB / 3.394 GB, free: 0.5771 GB / 1.779 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.445e-06/8.668, allocations: 0 / 3.394 GB, free: 0.5771 GB / 1.779 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1226/8.791, allocations: 54.28 MB / 3.447 GB, free: 0.524 GB / 1.779 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01754/8.808, allocations: 5.879 MB / 3.453 GB, free: 0.5185 GB / 1.779 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.009016/8.817, allocations: 420 kB / 3.453 GB, free: 0.5181 GB / 1.779 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02768/8.845, allocations: 1.167 MB / 3.454 GB, free: 0.517 GB / 1.779 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.008582/8.854, allocations: 1.391 MB / 3.456 GB, free: 0.5156 GB / 1.779 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.006226/8.86, allocations: 0.7339 MB / 3.456 GB, free: 0.5149 GB / 1.779 GB
Notification: Performance of sorting global known variables: time 0.01623/8.876, allocations: 7.692 MB / 3.464 GB, free: 0.5074 GB / 1.779 GB
Notification: Performance of sort global known variables: time 2e-07/8.876, allocations: 0 / 3.464 GB, free: 0.5074 GB / 1.779 GB
Notification: Performance of remove unused functions: time 0.03322/8.909, allocations: 9.452 MB / 3.473 GB, free: 0.4986 GB / 1.779 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 6
 * Number of states: 108 (zoneHallway.volumeHall.dynBal.medium.Xi[1],zoneHallway.volumeHall.dynBal.U,zoneHallway.volumeHall.dynBal.m,zoneHallway.oriOutTop.mExc,zoneHallway.oriOutBottom.mExc,simpleZone1_4.volRoom.dynBal.medium.Xi[1],simpleZone1_4.volRoom.dynBal.U,simpleZone1_4.volRoom.dynBal.m,simpleZone1_4.door.mExcAB,simpleZone1_4.door.mExcBA,zoneHallway1.volumeHall.dynBal.medium.Xi[1],zoneHallway1.volumeHall.dynBal.U,zoneHallway1.volumeHall.dynBal.m,zoneHallway1.oriOutTop.mExc,zoneHallway1.oriOutBottom.mExc,zoneHallway1.ori.mExc,zoneHallway1.ori1.mExc,zoneHallway2.volumeHall.dynBal.medium.Xi[1],zoneHallway2.volumeHall.dynBal.U,zoneHallway2.volumeHall.dynBal.m,zoneHallway2.oriOutTop.mExc,zoneHallway2.oriOutBottom.mExc,zoneHallway2.ori.mExc,zoneHallway2.ori1.mExc,zoneHallway3.volumeHall.dynBal.medium.Xi[1],zoneHallway3.volumeHall.dynBal.U,zoneHallway3.volumeHall.dynBal.m,zoneHallway3.oriOutTop.mExc,zoneHallway3.oriOutBottom.mExc,zoneHallway3.ori.mExc,zoneHallway3.ori1.mExc,simpleZone1_3.volRoom.dynBal.medium.Xi[1],simpleZone1_3.volRoom.dynBal.U,simpleZone1_3.volRoom.dynBal.m,simpleZone1_3.door.mExcAB,simpleZone1_3.door.mExcBA,simpleZone1_2.volRoom.dynBal.medium.Xi[1],simpleZone1_2.volRoom.dynBal.U,simpleZone1_2.volRoom.dynBal.m,simpleZone1_2.door.mExcAB,simpleZone1_2.door.mExcBA,simpleZone1_1.volRoom.dynBal.medium.Xi[1],simpleZone1_1.volRoom.dynBal.U,simpleZone1_1.volRoom.dynBal.m,simpleZone1_1.door.mExcAB,simpleZone1_1.door.mExcBA,zoneHallway4.volumeHall.dynBal.medium.Xi[1],zoneHallway4.volumeHall.dynBal.U,zoneHallway4.volumeHall.dynBal.m,zoneHallway4.oriOutTop.mExc,zoneHallway4.oriOutBottom.mExc,simpleZone2_4.volRoom.dynBal.medium.Xi[1],simpleZone2_4.volRoom.dynBal.U,simpleZone2_4.volRoom.dynBal.m,simpleZone2_4.door.mExcAB,simpleZone2_4.door.mExcBA,zoneHallway5.volumeHall.dynBal.medium.Xi[1],zoneHallway5.volumeHall.dynBal.U,zoneHallway5.volumeHall.dynBal.m,zoneHallway5.oriOutTop.mExc,zoneHallway5.oriOutBottom.mExc,zoneHallway5.ori.mExc,zoneHallway5.ori1.mExc,zoneHallway6.volumeHall.dynBal.medium.Xi[1],zoneHallway6.volumeHall.dynBal.U,zoneHallway6.volumeHall.dynBal.m,zoneHallway6.oriOutTop.mExc,zoneHallway6.oriOutBottom.mExc,zoneHallway6.ori.mExc,zoneHallway6.ori1.mExc,zoneHallway7.volumeHall.dynBal.medium.Xi[1],zoneHallway7.volumeHall.dynBal.U,zoneHallway7.volumeHall.dynBal.m,zoneHallway7.oriOutTop.mExc,zoneHallway7.oriOutBottom.mExc,zoneHallway7.ori.mExc,zoneHallway7.ori1.mExc,simpleZone2_3.volRoom.dynBal.medium.Xi[1],simpleZone2_3.volRoom.dynBal.U,simpleZone2_3.volRoom.dynBal.m,simpleZone2_3.door.mExcAB,simpleZone2_3.door.mExcBA,simpleZone2_2.volRoom.dynBal.medium.Xi[1],simpleZone2_2.volRoom.dynBal.U,simpleZone2_2.volRoom.dynBal.m,simpleZone2_2.door.mExcAB,simpleZone2_2.door.mExcBA,simpleZone2_1.volRoom.dynBal.medium.Xi[1],simpleZone2_1.volRoom.dynBal.U,simpleZone2_1.volRoom.dynBal.m,simpleZone2_1.door.mExcAB,simpleZone2_1.door.mExcBA,staircase1.volumeStairs.dynBal.medium.Xi[1],staircase1.volumeStairs.dynBal.U,staircase1.volumeStairs.dynBal.m,staircase1.ori.mExc,staircase1.doo.mExcAB,staircase1.doo.mExcBA,staircase2.volumeStairs.dynBal.medium.Xi[1],staircase2.volumeStairs.dynBal.U,staircase2.volumeStairs.dynBal.m,staircase2.doo.mExcAB,staircase2.doo.mExcBA,staircase2.ori.mExc,zoneHallway4.ori1.mExc,zoneHallway4.ori.mExc,zoneHallway.ori1.mExc,zoneHallway.ori.mExc)
 * Number of discrete variables: 10 ($whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext)
 * Number of discrete states: 5 (weaDat.conTimMin.tNext,weaDat.decAng.tNext,weaDat.eqnTim.tNext,weaDat.conTim.tNext,weaDat.locTim.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (2297):
 * Single equations (assignments): 2260
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 5
 * If-equations: 0
 * Equation systems (not torn): 5
 * Torn equation systems: 27
 * 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): 26 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%), (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%), (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%), (1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.1379/9.047, allocations: 57.31 MB / 3.529 GB, free: 453.3 MB / 1.779 GB
Notification: Performance of simCode: created initialization part: time 0.09515/9.142, allocations: 34.57 MB / 3.563 GB, free: 418.6 MB / 1.779 GB
Notification: Performance of simCode: created event and clocks part: time 1.852e-05/9.142, allocations: 12.02 kB / 3.563 GB, free: 418.6 MB / 1.779 GB
Notification: Performance of simCode: created simulation system equations: time 0.07664/9.219, allocations: 22.61 MB / 3.585 GB, free: 395.7 MB / 1.779 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05884/9.278, allocations: 9.856 MB / 3.594 GB, free: 386.1 MB / 1.779 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4489/9.727, allocations: 195.1 MB / 3.785 GB, free: 189.7 MB / 1.779 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01845/9.745, allocations: 12.04 MB / 3.797 GB, free: 177.6 MB / 1.779 GB
Notification: Performance of simCode: alias equations: time 0.04032/9.785, allocations: 8.039 MB / 3.805 GB, free: 169.6 MB / 1.779 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.03088/9.816, allocations: 11.91 MB / 3.816 GB, free: 157.7 MB / 1.779 GB
Notification: Performance of SimCode: time 1.834e-06/9.816, allocations: 0 / 3.816 GB, free: 157.7 MB / 1.779 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.696/11.51, allocations: 0.6091 GB / 4.425 GB, free: 0.7093 GB / 1.78 GB
Notification: Performance of buildModelFMU: Generate platform static: time 91.89/103.4, allocations: 7.969 kB / 4.425 GB, free: 0.7093 GB / 1.78 GB
"
[Timeout remaining time 556]
(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 & python3 -m fmpy simulate  --output-file IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors_res.csv --start-time 0 --stop-time 3600 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 1.44 IBPSA_latest_IBPSA_Experimental_Benchmarks_AirFlow_Examples_TwoFloors.fmu > IBPSA_latest_IBPSA.Experimental.Benchmarks.AirFlow.Examples.TwoFloors.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 108.9391683100257]
Failed to read output from testmodel.py, exit status != 0:
103.99987748684362 104.008707234 98.22151611
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ffa26122ce0>