Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example1v2.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.001094/0.001094, allocations: 80.44 kB / 19.17 MB, free: 0.7422 MB / 13.93 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.001192/0.001192, allocations: 165.9 kB / 22.45 MB, free: 2.105 MB / 18.57 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 0.9275/0.9275, allocations: 177.1 MB / 202.8 MB, free: 5.738 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/Building/BuildingEnvelope/HeatTransfer/package.mo:2:1-40:17:writable] Warning: Soil_case_nappe was referenced in the package.order file, but was not found in package.mo, Soil_case_nappe/package.mo or Soil_case_nappe.mo.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/package.mo): time 0.5549/0.5549, allocations: 110.2 MB / 369.4 MB, free: 12.62 MB / 346.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/BoundaryConditions/Scenarios/CombiTimeTable.mo:44:3-56:20:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/BoundaryConditions/Scenarios/CombiTimeTable.mo:58:3-65:19:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/BoundaryConditions/Scenarios/CombiTimeTable.mo:67:3-72:20:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/BoundaryConditions/Scenarios/CombiTimeTable.mo:74:3-79:20:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 179]
Using package BuildSysPro with version 3.6.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/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(BuildSysPro.IBPSA.Fluid.Examples.Performance.Example1v2,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_Examples_Performance_Example1v2",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(BuildSysPro.IBPSA.Fluid.Examples.Performance.Example1v2,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_Examples_Performance_Example1v2",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 2.595e-06/2.595e-06, allocations: 0 / 0.5473 GB, free: 9.828 MB / 0.5105 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.239e-05/2.499e-05, allocations: 6.281 kB / 0.5473 GB, free: 9.82 MB / 0.5105 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pump.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.Examples.Performance.Example1v2): time 0.05262/0.05265, allocations: 73.95 MB / 0.6195 GB, free: 15.61 MB / 0.5886 GB
Notification: Performance of NFInst.instExpressions: time 0.02371/0.07636, allocations: 19.65 MB / 0.6387 GB, free: 11.91 MB / 0.6042 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003399/0.07976, allocations: 142.8 kB / 0.6388 GB, free: 11.77 MB / 0.6042 GB
Notification: Performance of NFTyping.typeComponents: time 0.004877/0.08464, allocations: 2.008 MB / 0.6408 GB, free: 9.754 MB / 0.6042 GB
Notification: Performance of NFTyping.typeBindings: time 0.006402/0.09104, allocations: 3.176 MB / 0.6439 GB, free: 6.562 MB / 0.6042 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004673/0.09571, allocations: 2.613 MB / 0.6464 GB, free: 3.957 MB / 0.6042 GB
Notification: Performance of NFFlatten.flatten: time 0.02223/0.1179, allocations: 31.83 MB / 0.6775 GB, free: 4.035 MB / 0.6355 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.2835/0.4015, allocations: 12.45 MB / 0.6897 GB, free: 55.99 MB / 0.6355 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02861/0.4301, allocations: 15.29 MB / 0.7046 GB, free: 55.93 MB / 0.6355 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02128/0.4514, allocations: 12.1 MB / 0.7164 GB, free: 55.86 MB / 0.6355 GB
Notification: Performance of NFPackage.collectConstants: time 0.007267/0.4586, allocations: 1.29 MB / 0.7177 GB, free: 55.86 MB / 0.6355 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01183/0.4705, allocations: 2.29 MB / 0.7199 GB, free: 55.84 MB / 0.6355 GB
Notification: Performance of NFScalarize.scalarize: time 0.009864/0.4803, allocations: 3.991 MB / 0.7238 GB, free: 55.84 MB / 0.6355 GB
Notification: Performance of NFVerifyModel.verify: time 0.01852/0.4989, allocations: 5.005 MB / 0.7287 GB, free: 55.84 MB / 0.6355 GB
Notification: Performance of NFConvertDAE.convert: time 0.03101/0.5299, allocations: 21.04 MB / 0.7492 GB, free: 54.96 MB / 0.6355 GB
Notification: Performance of FrontEnd - DAE generated: time 7.334e-06/0.5299, allocations: 0 / 0.7492 GB, free: 54.96 MB / 0.6355 GB
Notification: Performance of FrontEnd: time 2.023e-06/0.5299, allocations: 2.297 kB / 0.7492 GB, free: 54.96 MB / 0.6355 GB
Notification: Performance of Transformations before backend: time 0.0005935/0.5305, allocations: 0 / 0.7492 GB, free: 54.96 MB / 0.6355 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1422
 * Number of variables: 1422
Notification: Performance of Generate backend data structure: time 0.03562/0.5661, allocations: 11.53 MB / 0.7605 GB, free: 49.14 MB / 0.6355 GB
Notification: Performance of prepare preOptimizeDAE: time 5.719e-05/0.5662, allocations: 8.969 kB / 0.7605 GB, free: 49.14 MB / 0.6355 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.004867/0.571, allocations: 0.7703 MB / 0.7613 GB, free: 48.59 MB / 0.6355 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008483/0.5795, allocations: 1.455 MB / 0.7627 GB, free: 47.87 MB / 0.6355 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02171/0.6012, allocations: 11.47 MB / 0.7739 GB, free: 41.5 MB / 0.6355 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004449/0.6017, allocations: 442.2 kB / 0.7743 GB, free: 41.3 MB / 0.6355 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.006337/0.608, allocations: 0.5847 MB / 0.7749 GB, free: 41.11 MB / 0.6355 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03215/0.6402, allocations: 16.39 MB / 0.7909 GB, free: 29.91 MB / 0.6355 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002199/0.6404, allocations: 21.47 kB / 0.7909 GB, free: 29.9 MB / 0.6355 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003974/0.6443, allocations: 244.4 kB / 0.7911 GB, free: 29.72 MB / 0.6355 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.339e-05/0.6444, allocations: 140.1 kB / 0.7913 GB, free: 29.72 MB / 0.6355 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02752/0.6719, allocations: 20.1 MB / 0.8109 GB, free: 15.43 MB / 0.6355 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.09174/0.7637, allocations: 52.17 MB / 0.8618 GB, free: 11.68 MB / 0.6823 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01147/0.7752, allocations: 8.173 MB / 0.8698 GB, free: 3.504 MB / 0.6823 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01014/0.7853, allocations: 7.593 MB / 0.8772 GB, free: 11.91 MB / 0.698 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.04505/0.8303, allocations: 24.28 MB / 0.901 GB, free: 3.645 MB / 0.7136 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01102/0.8414, allocations: 8.835 MB / 0.9096 GB, free: 10.5 MB / 0.7292 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01652/0.8579, allocations: 6.998 MB / 0.9164 GB, free: 3.664 MB / 0.7292 GB
Notification: Performance of pre-optimization done (n=298): time 2.63e-05/0.8579, allocations: 3.188 kB / 0.9164 GB, free: 3.664 MB / 0.7292 GB
Notification: Performance of matching and sorting (n=298): time 0.044/0.9019, allocations: 23.61 MB / 0.9395 GB, free: 12.03 MB / 0.7605 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.322e-05/0.902, allocations: 89.67 kB / 0.9396 GB, free: 11.93 MB / 0.7605 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01654/0.9185, allocations: 8.844 MB / 0.9482 GB, free: 3.133 MB / 0.7605 GB
Notification: Performance of collectPreVariables (initialization): time 0.0022/0.9207, allocations: 93.7 kB / 0.9483 GB, free: 3.035 MB / 0.7605 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004987/0.9257, allocations: 4.334 MB / 0.9525 GB, free: 14.7 MB / 0.7761 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003296/0.929, allocations: 1.111 MB / 0.9536 GB, free: 13.6 MB / 0.7761 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00344/0.9324, allocations: 1.662 MB / 0.9552 GB, free: 11.93 MB / 0.7761 GB
Notification: Performance of setup shared object (initialization): time 8.582e-05/0.9325, allocations: 301.1 kB / 0.9555 GB, free: 11.63 MB / 0.7761 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007805/0.9403, allocations: 6.565 MB / 0.9619 GB, free: 5.031 MB / 0.7761 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.3028/1.243, allocations: 9.592 MB / 0.9713 GB, free: 270.4 MB / 0.7761 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02251/1.266, allocations: 15.25 MB / 0.9862 GB, free: 265.5 MB / 0.7761 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.026e-05/1.266, allocations: 14.31 kB / 0.9862 GB, free: 265.5 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=578) (initialization): time 0.03141/1.297, allocations: 17.64 MB / 1.003 GB, free: 259.5 MB / 0.7761 GB
Notification: Performance of prepare postOptimizeDAE: time 8.474e-05/1.297, allocations: 57.59 kB / 1.003 GB, free: 259.5 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.669e-05/1.297, allocations: 48.53 kB / 1.004 GB, free: 259.5 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03396/1.331, allocations: 11.58 MB / 1.015 GB, free: 258.4 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006331/1.338, allocations: 1.553 MB / 1.016 GB, free: 258.3 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004315/1.342, allocations: 3.777 MB / 1.02 GB, free: 256.3 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00944/1.351, allocations: 359.8 kB / 1.02 GB, free: 256.2 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002658/1.354, allocations: 0.5405 MB / 1.021 GB, free: 256.1 MB / 0.7761 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01487/1.369, allocations: 8.961 MB / 1.03 GB, free: 252.9 MB / 0.7761 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01005/1.379, allocations: 9.562 MB / 1.039 GB, free: 246.6 MB / 0.7761 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01758/1.396, allocations: 15.19 MB / 1.054 GB, free: 237.3 MB / 0.7761 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.57e-05/1.397, allocations: 16 kB / 1.054 GB, free: 237.3 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=578) (initialization_lambda0): time 0.03051/1.427, allocations: 17.43 MB / 1.071 GB, free: 222.4 MB / 0.7761 GB
Notification: Performance of prepare postOptimizeDAE: time 5.58e-05/1.427, allocations: 53.69 kB / 1.071 GB, free: 222.3 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.588e-05/1.427, allocations: 55.94 kB / 1.071 GB, free: 222.2 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02913/1.456, allocations: 11.14 MB / 1.082 GB, free: 211.1 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005371/1.462, allocations: 1.549 MB / 1.083 GB, free: 209.6 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005937/1.468, allocations: 7.843 MB / 1.091 GB, free: 201.6 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008388/1.476, allocations: 364.6 kB / 1.091 GB, free: 201.3 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002206/1.478, allocations: 0.5382 MB / 1.092 GB, free: 200.7 MB / 0.7761 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 220
 * Number of states: 0 ()
 * Number of discrete variables: 8 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,from_dp.y,nRes.y,allowFlowReversal.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (524):
 * Single equations (assignments): 519
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(2,5), (20,21), (2,5)}
Notification: Performance of prepare postOptimizeDAE: time 0.003519/1.482, allocations: 490.4 kB / 1.092 GB, free: 200.3 MB / 0.7761 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00364/1.485, allocations: 0.8537 MB / 1.093 GB, free: 199.6 MB / 0.7761 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01998/1.505, allocations: 14.1 MB / 1.107 GB, free: 185.5 MB / 0.7761 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.866e-05/1.505, allocations: 39.94 kB / 1.107 GB, free: 185.4 MB / 0.7761 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.829e-06/1.505, allocations: 4 kB / 1.107 GB, free: 185.4 MB / 0.7761 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01166/1.517, allocations: 10.65 MB / 1.117 GB, free: 174.7 MB / 0.7761 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.03357/1.551, allocations: 23.67 MB / 1.141 GB, free: 151.1 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.245e-05/1.551, allocations: 0 / 1.141 GB, free: 151.1 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00316/1.554, allocations: 0.6886 MB / 1.141 GB, free: 150.4 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.02903/1.583, allocations: 10.74 MB / 1.152 GB, free: 139.7 MB / 0.7761 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001405/1.584, allocations: 104.7 kB / 1.152 GB, free: 139.6 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002254/1.586, allocations: 3.116 MB / 1.155 GB, free: 136.4 MB / 0.7761 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.695e-06/1.586, allocations: 0 / 1.155 GB, free: 136.4 MB / 0.7761 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02263/1.609, allocations: 19.39 MB / 1.174 GB, free: 116.9 MB / 0.7761 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005556/1.615, allocations: 1.921 MB / 1.176 GB, free: 115 MB / 0.7761 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003338/1.618, allocations: 71.98 kB / 1.176 GB, free: 114.9 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006281/1.624, allocations: 221.3 kB / 1.176 GB, free: 114.7 MB / 0.7761 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001336/1.626, allocations: 230.4 kB / 1.176 GB, free: 114.5 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0005703/1.626, allocations: 159.9 kB / 1.176 GB, free: 114.3 MB / 0.7761 GB
Notification: Performance of sorting global known variables: time 0.009209/1.635, allocations: 6.056 MB / 1.182 GB, free: 108.3 MB / 0.7761 GB
Notification: Performance of sort global known variables: time 2e-07/1.635, allocations: 0 / 1.182 GB, free: 108.3 MB / 0.7761 GB
Notification: Performance of remove unused functions: time 0.01831/1.654, allocations: 4.835 MB / 1.187 GB, free: 103.7 MB / 0.7761 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 22 (pump.vol.dynBal.U,hea.outCon.T,vol[1].dynBal.U,vol[2].dynBal.U,vol[3].dynBal.U,vol[4].dynBal.U,vol[5].dynBal.U,vol[6].dynBal.U,vol[7].dynBal.U,vol[8].dynBal.U,vol[9].dynBal.U,vol[10].dynBal.U,vol[11].dynBal.U,vol[12].dynBal.U,vol[13].dynBal.U,vol[14].dynBal.U,vol[15].dynBal.U,vol[16].dynBal.U,vol[17].dynBal.U,vol[18].dynBal.U,vol[19].dynBal.U,vol[20].dynBal.U)
 * Number of discrete variables: 3 ($whenCondition1,pulse.T_start,pulse.count)
 * Number of discrete states: 1 (pulse.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (300):
 * Single equations (assignments): 291
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 4
 * When equations: 2
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(2,5), (2,5), (20,21)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.02267/1.676, allocations: 20.21 MB / 1.207 GB, free: 83.5 MB / 0.7761 GB
Notification: Performance of simCode: created initialization part: time 0.02828/1.705, allocations: 21.42 MB / 1.228 GB, free: 62.01 MB / 0.7761 GB
Notification: Performance of simCode: created event and clocks part: time 1.195e-05/1.705, allocations: 4 kB / 1.228 GB, free: 62.01 MB / 0.7761 GB
Notification: Performance of simCode: created simulation system equations: time 0.00675/1.711, allocations: 5.288 MB / 1.233 GB, free: 56.72 MB / 0.7761 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01872/1.73, allocations: 5.207 MB / 1.238 GB, free: 51.71 MB / 0.7761 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4166/2.147, allocations: 95.95 MB / 1.332 GB, free: 250.1 MB / 0.7761 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00919/2.156, allocations: 4.99 MB / 1.336 GB, free: 249 MB / 0.7761 GB
Notification: Performance of simCode: alias equations: time 0.01931/2.175, allocations: 5.237 MB / 1.342 GB, free: 248.6 MB / 0.7761 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.009339/2.185, allocations: 4.074 MB / 1.346 GB, free: 245.7 MB / 0.7761 GB
Notification: Performance of SimCode: time 1.553e-06/2.185, allocations: 0 / 1.346 GB, free: 245.7 MB / 0.7761 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.4877/2.672, allocations: 313.8 MB / 1.652 GB, free: 245.6 MB / 0.7761 GB
Notification: Performance of buildModelFMU: Generate platform static: time 18.92/21.59, allocations: 8.312 kB / 1.652 GB, free: 245.6 MB / 0.7761 GB
"
[Timeout remaining time 638]
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example1v2.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example1v2.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example1v2.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example1v2.sim & python3 -m fmpy simulate  --output-file BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example1v2_res.csv --start-time 0 --stop-time 20 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.008 BuildSysPro_BuildSysPro_IBPSA_Fluid_Examples_Performance_Example1v2.fmu > BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example1v2.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 24.397370072081685]
Failed to read output from testmodel.py, exit status != 0:
21.792757955379784 21.802420435 21.270152567
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x76dab68b2c60>