Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.FMI.Validation.HeaterFan.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.0008932/0.0008932, 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.000898/0.000898, allocations: 169.9 kB / 22.46 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.93/0.93, allocations: 177.1 MB / 202.8 MB, free: 5.746 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.5487/0.5487, allocations: 110.2 MB / 369.4 MB, free: 12.6 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.FMI.Validation.HeaterFan,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_FMI_Validation_HeaterFan",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(BuildSysPro.IBPSA.Fluid.FMI.Validation.HeaterFan,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_FMI_Validation_HeaterFan",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.784e-06/1.784e-06, allocations: 0 / 0.5473 GB, free: 9.84 MB / 0.5105 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.004e-05/2.182e-05, allocations: 6.219 kB / 0.5473 GB, free: 9.832 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 floMac.com.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.FMI.Validation.HeaterFan): time 0.481/0.481, allocations: 278.7 MB / 0.8194 GB, free: 14.18 MB / 0.6511 GB
Notification: Performance of NFInst.instExpressions: time 0.03027/0.5112, allocations: 27.09 MB / 0.8459 GB, free: 11.9 MB / 0.6667 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003479/0.5147, allocations: 107.3 kB / 0.846 GB, free: 11.85 MB / 0.6667 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Inlet.mo:35:3-38:60:writable] Warning: Connector bacPro_internal is not balanced: The number of potential variables (2) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Inlet.mo:41:3-42:70:writable] Warning: Connector X_w_in_internal is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Inlet.mo:43:3-44:71:writable] Warning: Connector X_w_out_internal is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Outlet.mo:37:3-40:60:writable] Warning: Connector bacPro_internal is not balanced: The number of potential variables (2) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Outlet.mo:44:3-45:70:writable] Warning: Connector X_w_in_internal is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Outlet.mo:46:3-47:71:writable] Warning: Connector X_w_out_internal is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Inlet.mo:35:3-38:60:writable] Warning: Connector bacPro_internal is not balanced: The number of potential variables (2) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Inlet.mo:41:3-42:70:writable] Warning: Connector X_w_in_internal is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Inlet.mo:43:3-44:71:writable] Warning: Connector X_w_out_internal is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Outlet.mo:37:3-40:60:writable] Warning: Connector bacPro_internal is not balanced: The number of potential variables (2) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Outlet.mo:44:3-45:70:writable] Warning: Connector X_w_in_internal is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Adaptors/Outlet.mo:46:3-47:71:writable] Warning: Connector X_w_out_internal is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Source_T.mo:50:3-51:70:writable] Warning: Connector X_w_in_internal is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/IBPSA/Fluid/FMI/Sink_T.mo:47:3-50:60:writable] Warning: Connector bacPro_internal is not balanced: The number of potential variables (2) is not equal to the number of flow variables (0).
Notification: Performance of NFTyping.typeComponents: time 0.006332/0.5211, allocations: 2.448 MB / 0.8484 GB, free: 10.59 MB / 0.6667 GB
Notification: Performance of NFTyping.typeBindings: time 0.008318/0.5294, allocations: 3.425 MB / 0.8517 GB, free: 7.91 MB / 0.6667 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00611/0.5355, allocations: 2.885 MB / 0.8546 GB, free: 5.895 MB / 0.6667 GB
Notification: Performance of NFFlatten.flatten: time 0.01095/0.5464, allocations: 8.693 MB / 0.863 GB, free: 1.137 MB / 0.6667 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002682/0.5491, allocations: 1.555 MB / 0.8646 GB, free: 15.96 MB / 0.6823 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006039/0.5552, allocations: 3.219 MB / 0.8677 GB, free: 13.36 MB / 0.6823 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00247/0.5576, allocations: 1.366 MB / 0.869 GB, free: 12.01 MB / 0.6823 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003823/0.558, allocations: 240 kB / 0.8693 GB, free: 11.77 MB / 0.6823 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.004858/0.5629, allocations: 2.711 MB / 0.8719 GB, free: 9.055 MB / 0.6823 GB
Notification: Performance of NFScalarize.scalarize: time 0.001011/0.5639, allocations: 0.8684 MB / 0.8728 GB, free: 8.184 MB / 0.6823 GB
Notification: Performance of NFVerifyModel.verify: time 0.001456/0.5653, allocations: 0.8925 MB / 0.8736 GB, free: 7.289 MB / 0.6823 GB
Notification: Performance of NFConvertDAE.convert: time 0.00701/0.5723, allocations: 5.402 MB / 0.8789 GB, free: 1.871 MB / 0.6823 GB
Notification: Performance of FrontEnd - DAE generated: time 7.504e-06/0.5724, allocations: 0 / 0.8789 GB, free: 1.871 MB / 0.6823 GB
Notification: Performance of FrontEnd: time 2.134e-06/0.5724, allocations: 0 / 0.8789 GB, free: 1.871 MB / 0.6823 GB
Notification: Performance of Transformations before backend: time 8.172e-05/0.5724, allocations: 4 kB / 0.8789 GB, free: 1.867 MB / 0.6823 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 332
 * Number of variables: 332
Notification: Performance of Generate backend data structure: time 0.004084/0.5765, allocations: 2.879 MB / 0.8817 GB, free: 14.93 MB / 0.698 GB
Notification: Performance of prepare preOptimizeDAE: time 5.294e-05/0.5766, allocations: 8.031 kB / 0.8817 GB, free: 14.92 MB / 0.698 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001925/0.5768, allocations: 194.3 kB / 0.8819 GB, free: 14.72 MB / 0.698 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003153/0.5799, allocations: 0.9661 MB / 0.8829 GB, free: 13.75 MB / 0.698 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.007659/0.5876, allocations: 5.916 MB / 0.8886 GB, free: 7.746 MB / 0.698 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.311e-05/0.5877, allocations: 102.6 kB / 0.8887 GB, free: 7.645 MB / 0.698 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001505/0.5878, allocations: 128 kB / 0.8889 GB, free: 7.52 MB / 0.698 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002217/0.59, allocations: 1.657 MB / 0.8905 GB, free: 5.777 MB / 0.698 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.321e-05/0.59, allocations: 0 / 0.8905 GB, free: 5.777 MB / 0.698 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.857e-05/0.5901, allocations: 63.98 kB / 0.8905 GB, free: 5.715 MB / 0.698 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.951e-05/0.5902, allocations: 54.38 kB / 0.8906 GB, free: 5.66 MB / 0.698 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001945/0.5921, allocations: 1.321 MB / 0.8919 GB, free: 4.332 MB / 0.698 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.00658/0.5987, allocations: 5.514 MB / 0.8973 GB, free: 14.65 MB / 0.7136 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001081/0.5998, allocations: 0.5693 MB / 0.8978 GB, free: 14.07 MB / 0.7136 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003786/0.6002, allocations: 242.8 kB / 0.8981 GB, free: 13.84 MB / 0.7136 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.000147/0.6003, allocations: 43.97 kB / 0.8981 GB, free: 13.79 MB / 0.7136 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.472e-05/0.6003, allocations: 38.56 kB / 0.8981 GB, free: 13.75 MB / 0.7136 GB
Notification: Performance of pre-optimization done (n=35): time 2.735e-06/0.6003, allocations: 0 / 0.8981 GB, free: 13.75 MB / 0.7136 GB
Notification: Performance of matching and sorting (n=35): time 0.001803/0.6021, allocations: 0.8995 MB / 0.899 GB, free: 12.84 MB / 0.7136 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.01e-05/0.6022, allocations: 55.41 kB / 0.8991 GB, free: 12.77 MB / 0.7136 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002181/0.6043, allocations: 2.256 MB / 0.9013 GB, free: 10.5 MB / 0.7136 GB
Notification: Performance of collectPreVariables (initialization): time 5.293e-05/0.6044, allocations: 37.7 kB / 0.9013 GB, free: 10.45 MB / 0.7136 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007124/0.6051, allocations: 1.03 MB / 0.9023 GB, free: 9.414 MB / 0.7136 GB
Notification: Performance of collectInitialBindings (initialization): time 9.014e-05/0.6052, allocations: 125.1 kB / 0.9024 GB, free: 9.293 MB / 0.7136 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005066/0.6057, allocations: 146.1 kB / 0.9026 GB, free: 9.141 MB / 0.7136 GB
Notification: Performance of setup shared object (initialization): time 0.0001054/0.6058, allocations: 329.9 kB / 0.9029 GB, free: 8.812 MB / 0.7136 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005531/0.6064, allocations: 322.3 kB / 0.9032 GB, free: 8.5 MB / 0.7136 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007049/0.6071, allocations: 0.6655 MB / 0.9038 GB, free: 7.695 MB / 0.7136 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0009842/0.6081, allocations: 0.7522 MB / 0.9046 GB, free: 6.848 MB / 0.7136 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.889e-06/0.6081, allocations: 0 / 0.9046 GB, free: 6.848 MB / 0.7136 GB
Notification: Performance of matching and sorting (n=72) (initialization): time 0.001829/0.6099, allocations: 1.063 MB / 0.9056 GB, free: 5.773 MB / 0.7136 GB
Notification: Performance of prepare postOptimizeDAE: time 2.942e-05/0.6099, allocations: 8 kB / 0.9056 GB, free: 5.766 MB / 0.7136 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.517e-05/0.6099, allocations: 8 kB / 0.9056 GB, free: 5.758 MB / 0.7136 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002036/0.6101, allocations: 36.78 kB / 0.9057 GB, free: 5.719 MB / 0.7136 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005755/0.6107, allocations: 188.1 kB / 0.9058 GB, free: 5.535 MB / 0.7136 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001274/0.612, allocations: 1.468 MB / 0.9073 GB, free: 3.957 MB / 0.7136 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00115/0.6131, allocations: 215.5 kB / 0.9075 GB, free: 3.746 MB / 0.7136 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.223e-05/0.6132, allocations: 31.98 kB / 0.9075 GB, free: 3.715 MB / 0.7136 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001237/0.6144, allocations: 0.8019 MB / 0.9083 GB, free: 2.91 MB / 0.7136 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0006488/0.6151, allocations: 0.6501 MB / 0.9089 GB, free: 2.117 MB / 0.7136 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001188/0.6163, allocations: 0.7247 MB / 0.9096 GB, free: 1.297 MB / 0.7136 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.358e-06/0.6163, allocations: 0 / 0.9096 GB, free: 1.297 MB / 0.7136 GB
Notification: Performance of matching and sorting (n=72) (initialization_lambda0): time 0.001548/0.6178, allocations: 1.051 MB / 0.9107 GB, free: 240 kB / 0.7136 GB
Notification: Performance of prepare postOptimizeDAE: time 1.502e-05/0.6178, allocations: 8 kB / 0.9107 GB, free: 232 kB / 0.7136 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.396e-06/0.6178, allocations: 11.94 kB / 0.9107 GB, free: 220 kB / 0.7136 GB
Notification: Performance of postOpt tearingSystem (initialization): time 8.036e-05/0.6179, allocations: 33.22 kB / 0.9107 GB, free: 184 kB / 0.7136 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005029/0.6184, allocations: 191.7 kB / 0.9109 GB, free: 15.99 MB / 0.7292 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0009747/0.6194, allocations: 1.461 MB / 0.9123 GB, free: 14.43 MB / 0.7292 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009009/0.6203, allocations: 147.7 kB / 0.9125 GB, free: 14.29 MB / 0.7292 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.212e-05/0.6203, allocations: 31.98 kB / 0.9125 GB, free: 14.25 MB / 0.7292 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 31
 * 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 (69):
 * Single equations (assignments): 67
 * Array equations: 1
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0001842/0.6205, allocations: 220.1 kB / 0.9127 GB, free: 14.03 MB / 0.7292 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001852/0.6207, allocations: 222.6 kB / 0.9129 GB, free: 13.81 MB / 0.7292 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001241/0.6219, allocations: 0.7082 MB / 0.9136 GB, free: 13.09 MB / 0.7292 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.42e-06/0.622, allocations: 4 kB / 0.9136 GB, free: 13.08 MB / 0.7292 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.7e-06/0.622, allocations: 5.375 kB / 0.9136 GB, free: 13.08 MB / 0.7292 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.57e-06/0.622, allocations: 3.984 kB / 0.9136 GB, free: 13.07 MB / 0.7292 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002454/0.6244, allocations: 1.859 MB / 0.9154 GB, free: 11.14 MB / 0.7292 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.158e-06/0.6244, allocations: 0 / 0.9154 GB, free: 11.14 MB / 0.7292 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0003104/0.6247, allocations: 108 kB / 0.9155 GB, free: 11.04 MB / 0.7292 GB
Notification: Performance of postOpt tearingSystem (simulation): time 7.903e-05/0.6248, allocations: 24.84 kB / 0.9156 GB, free: 11.01 MB / 0.7292 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 2.886e-05/0.6248, allocations: 11.98 kB / 0.9156 GB, free: 11 MB / 0.7292 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001091/0.6259, allocations: 1.446 MB / 0.917 GB, free: 9.434 MB / 0.7292 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.016e-06/0.6259, allocations: 4.031 kB / 0.917 GB, free: 9.43 MB / 0.7292 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.000993/0.6269, allocations: 0.8236 MB / 0.9178 GB, free: 8.566 MB / 0.7292 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004123/0.6273, allocations: 278.3 kB / 0.9181 GB, free: 8.293 MB / 0.7292 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001292/0.6275, allocations: 11.88 kB / 0.9181 GB, free: 8.285 MB / 0.7292 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005038/0.628, allocations: 63.92 kB / 0.9181 GB, free: 8.223 MB / 0.7292 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 4.037e-05/0.628, allocations: 27.89 kB / 0.9182 GB, free: 8.195 MB / 0.7292 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 2.759e-05/0.628, allocations: 23.92 kB / 0.9182 GB, free: 8.172 MB / 0.7292 GB
Notification: Performance of sorting global known variables: time 0.001813/0.6299, allocations: 1.593 MB / 0.9197 GB, free: 6.57 MB / 0.7292 GB
Notification: Performance of sort global known variables: time 7.1e-08/0.6299, allocations: 0 / 0.9197 GB, free: 6.57 MB / 0.7292 GB
Notification: Performance of remove unused functions: time 0.001532/0.6314, allocations: 0.7566 MB / 0.9205 GB, free: 5.812 MB / 0.7292 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 8
 * 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 simulation (33):
 * Single equations (assignments): 32
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.001528/0.6329, allocations: 1.537 MB / 0.922 GB, free: 4.227 MB / 0.7292 GB
Notification: Performance of simCode: created initialization part: time 0.002305/0.6352, allocations: 1.213 MB / 0.9232 GB, free: 2.988 MB / 0.7292 GB
Notification: Performance of simCode: created event and clocks part: time 4.248e-06/0.6352, allocations: 0 / 0.9232 GB, free: 2.988 MB / 0.7292 GB
Notification: Performance of simCode: created simulation system equations: time 0.0004075/0.6356, allocations: 347.9 kB / 0.9235 GB, free: 2.637 MB / 0.7292 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003041/0.6387, allocations: 1.365 MB / 0.9248 GB, free: 1.301 MB / 0.7292 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01846/0.6571, allocations: 13.79 MB / 0.9383 GB, free: 3.086 MB / 0.7448 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007904/0.6579, allocations: 0.9597 MB / 0.9392 GB, free: 2.09 MB / 0.7448 GB
Notification: Performance of simCode: alias equations: time 0.001567/0.6595, allocations: 451.3 kB / 0.9397 GB, free: 1.645 MB / 0.7448 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007863/0.6603, allocations: 0.8166 MB / 0.9405 GB, free: 0.8281 MB / 0.7448 GB
Notification: Performance of SimCode: time 1.613e-06/0.6603, allocations: 0 / 0.9405 GB, free: 0.8281 MB / 0.7448 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.315/0.9753, allocations: 60.84 MB / 0.9999 GB, free: 300.6 MB / 0.7761 GB
Notification: Performance of buildModelFMU: Generate platform static: time 9.558/10.53, allocations: 2.406 kB / 0.9999 GB, free: 300.6 MB / 0.7761 GB
"
[Timeout remaining time 649]
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.FMI.Validation.HeaterFan.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.FMI.Validation.HeaterFan.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.FMI.Validation.HeaterFan.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.FMI.Validation.HeaterFan.sim & python3 -m fmpy simulate  --output-file BuildSysPro_BuildSysPro.IBPSA.Fluid.FMI.Validation.HeaterFan_res.csv --start-time 0 --stop-time 1 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.0004 BuildSysPro_BuildSysPro_IBPSA_Fluid_FMI_Validation_HeaterFan.fmu > BuildSysPro_BuildSysPro.IBPSA.Fluid.FMI.Validation.HeaterFan.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 13.1835913117975]
Failed to read output from testmodel.py, exit status != 0:
10.651514914818108 10.669137468 10.093267808
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f15893e3f20>