Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.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.0014/0.0014, allocations: 75.2 kB / 19.76 MB, free: 2.02 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.001519/0.001519, allocations: 161 kB / 23.01 MB, free: 4.957 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.447/1.447, allocations: 177.2 MB / 203.4 MB, free: 8.949 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.8386/0.8386, allocations: 101.3 MB / 361.1 MB, free: 9.547 MB / 334.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Utilities/Cryptographics/BaseClasses/sha.mo:2:1-19:8:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Utilities/File/sha2.mo:2:1-9:9:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 179]
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.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: translateModel(IDEAS.Fluid.FMI.Validation.HeaterFan,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.FMI.Validation.HeaterFan")
translateModel(IDEAS.Fluid.FMI.Validation.HeaterFan,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.FMI.Validation.HeaterFan") [Timeout 660]
"Notification: IDEAS 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.002426/0.002426, allocations: 66.7 kB / 0.5356 GB, free: 5.258 MB / 446.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Utilities/Cryptographics/BaseClasses/sha.mo:2:1-19:8:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Utilities/File/sha2.mo:2:1-9:9:writable] Warning: External function annotation should occur on the external-clause, not on the function.
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2114/0.2138, allocations: 85.88 MB / 0.6195 GB, free: 1.574 MB / 0.5137 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(IDEAS.Fluid.FMI.Validation.HeaterFan): time 0.7828/0.9966, allocations: 278.6 MB / 0.8916 GB, free: 14.55 MB / 0.7325 GB
Notification: Performance of NFInst.instExpressions: time 0.04131/1.038, allocations: 25.36 MB / 0.9164 GB, free: 5.125 MB / 0.7481 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004146/1.042, allocations: 107.2 kB / 0.9165 GB, free: 5.02 MB / 0.7481 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Fluid/FMI/Adaptors/Inlet.mo:38: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/IDEAS 3.0.0/Fluid/FMI/Adaptors/Inlet.mo:43:3-44: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/IDEAS 3.0.0/Fluid/FMI/Adaptors/Inlet.mo:45:3-46: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/IDEAS 3.0.0/Fluid/FMI/Adaptors/Outlet.mo:39:3-41: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/IDEAS 3.0.0/Fluid/FMI/Adaptors/Outlet.mo:45:3-46: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/IDEAS 3.0.0/Fluid/FMI/Adaptors/Outlet.mo:47:3-48: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/IDEAS 3.0.0/Fluid/FMI/Adaptors/Inlet.mo:38: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/IDEAS 3.0.0/Fluid/FMI/Adaptors/Inlet.mo:43:3-44: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/IDEAS 3.0.0/Fluid/FMI/Adaptors/Inlet.mo:45:3-46: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/IDEAS 3.0.0/Fluid/FMI/Adaptors/Outlet.mo:39:3-41: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/IDEAS 3.0.0/Fluid/FMI/Adaptors/Outlet.mo:45:3-46: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/IDEAS 3.0.0/Fluid/FMI/Adaptors/Outlet.mo:47:3-48: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/IDEAS 3.0.0/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/IDEAS 3.0.0/Fluid/FMI/Sink_T.mo:49:3-51: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.00547/1.048, allocations: 1.576 MB / 0.918 GB, free: 3.438 MB / 0.7481 GB
Notification: Performance of NFTyping.typeBindings: time 0.01042/1.058, allocations: 3.139 MB / 0.9211 GB, free: 292 kB / 0.7481 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007906/1.066, allocations: 2.654 MB / 0.9237 GB, free: 13.64 MB / 0.7637 GB
Notification: Performance of NFFlatten.flatten: time 0.008536/1.074, allocations: 4.652 MB / 0.9282 GB, free: 8.98 MB / 0.7637 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003046/1.077, allocations: 1.518 MB / 0.9297 GB, free: 7.418 MB / 0.7637 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006284/1.084, allocations: 2.703 MB / 0.9323 GB, free: 4.707 MB / 0.7637 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004247/1.088, allocations: 1.398 MB / 0.9337 GB, free: 3.309 MB / 0.7637 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004806/1.088, allocations: 228 kB / 0.9339 GB, free: 3.086 MB / 0.7637 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.007113/1.096, allocations: 2.821 MB / 0.9367 GB, free: 264 kB / 0.7637 GB
Notification: Performance of NFScalarize.scalarize: time 0.001059/1.097, allocations: 0.6814 MB / 0.9373 GB, free: 15.57 MB / 0.7794 GB
Notification: Performance of NFVerifyModel.verify: time 0.001606/1.098, allocations: 0.9218 MB / 0.9382 GB, free: 14.65 MB / 0.7794 GB
Notification: Performance of NFConvertDAE.convert: time 0.008672/1.107, allocations: 4.559 MB / 0.9427 GB, free: 10.07 MB / 0.7794 GB
Notification: Performance of FrontEnd - DAE generated: time 9.588e-06/1.107, allocations: 8 kB / 0.9427 GB, free: 10.07 MB / 0.7794 GB
Notification: Performance of FrontEnd: time 2.284e-06/1.107, allocations: 0 / 0.9427 GB, free: 10.07 MB / 0.7794 GB
Notification: Performance of Transformations before backend: time 8.613e-05/1.107, allocations: 0 / 0.9427 GB, free: 10.07 MB / 0.7794 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 328
 * Number of variables: 328
Notification: Performance of Generate backend data structure: time 0.00531/1.112, allocations: 2.433 MB / 0.9451 GB, free: 7.582 MB / 0.7794 GB
Notification: Performance of prepare preOptimizeDAE: time 4.256e-05/1.112, allocations: 12.03 kB / 0.9451 GB, free: 7.57 MB / 0.7794 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00533/1.118, allocations: 0.8248 MB / 0.9459 GB, free: 6.746 MB / 0.7794 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005277/1.123, allocations: 2.034 MB / 0.9479 GB, free: 4.645 MB / 0.7794 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001334/1.123, allocations: 102.6 kB / 0.948 GB, free: 4.543 MB / 0.7794 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000334/1.123, allocations: 132 kB / 0.9481 GB, free: 4.414 MB / 0.7794 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003645/1.127, allocations: 1.621 MB / 0.9497 GB, free: 2.711 MB / 0.7794 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.357e-05/1.127, allocations: 4 kB / 0.9497 GB, free: 2.707 MB / 0.7794 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001358/1.127, allocations: 55.94 kB / 0.9497 GB, free: 2.652 MB / 0.7794 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.674e-05/1.127, allocations: 46.5 kB / 0.9498 GB, free: 2.605 MB / 0.7794 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003278/1.131, allocations: 1.259 MB / 0.951 GB, free: 1.34 MB / 0.7794 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.009846/1.14, allocations: 4.914 MB / 0.9558 GB, free: 12.29 MB / 0.795 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002605/1.143, allocations: 0.5955 MB / 0.9564 GB, free: 11.69 MB / 0.795 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006413/1.144, allocations: 229.3 kB / 0.9566 GB, free: 11.46 MB / 0.795 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002417/1.144, allocations: 35.97 kB / 0.9566 GB, free: 11.43 MB / 0.795 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.878e-05/1.144, allocations: 38.56 kB / 0.9567 GB, free: 11.38 MB / 0.795 GB
Notification: Performance of pre-optimization done (n=36): time 2.604e-06/1.144, allocations: 0 / 0.9567 GB, free: 11.38 MB / 0.795 GB
Notification: Performance of matching and sorting (n=36): time 0.002855/1.147, allocations: 0.8419 MB / 0.9575 GB, free: 10.52 MB / 0.795 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.477e-05/1.147, allocations: 55.41 kB / 0.9576 GB, free: 10.46 MB / 0.795 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002337/1.149, allocations: 1.3 MB / 0.9588 GB, free: 9.145 MB / 0.795 GB
Notification: Performance of collectPreVariables (initialization): time 7.616e-05/1.149, allocations: 33.7 kB / 0.9589 GB, free: 9.105 MB / 0.795 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008031/1.15, allocations: 0.872 MB / 0.9597 GB, free: 8.227 MB / 0.795 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001367/1.15, allocations: 134.8 kB / 0.9598 GB, free: 8.094 MB / 0.795 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002773/1.151, allocations: 146.2 kB / 0.96 GB, free: 7.941 MB / 0.795 GB
Notification: Performance of setup shared object (initialization): time 0.0001629/1.151, allocations: 326 kB / 0.9603 GB, free: 7.617 MB / 0.795 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009918/1.152, allocations: 307.3 kB / 0.9606 GB, free: 7.316 MB / 0.795 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001264/1.153, allocations: 0.6665 MB / 0.9612 GB, free: 6.512 MB / 0.795 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001734/1.155, allocations: 0.7192 MB / 0.9619 GB, free: 5.707 MB / 0.795 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.44e-06/1.155, allocations: 0 / 0.9619 GB, free: 5.707 MB / 0.795 GB
Notification: Performance of matching and sorting (n=72) (initialization): time 0.002859/1.158, allocations: 0.9903 MB / 0.9629 GB, free: 4.703 MB / 0.795 GB
Notification: Performance of prepare postOptimizeDAE: time 2.304e-05/1.158, allocations: 12.03 kB / 0.9629 GB, free: 4.691 MB / 0.795 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.584e-05/1.158, allocations: 8.875 kB / 0.9629 GB, free: 4.684 MB / 0.795 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002355/1.158, allocations: 61.62 kB / 0.963 GB, free: 4.617 MB / 0.795 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009847/1.159, allocations: 175.7 kB / 0.9631 GB, free: 4.445 MB / 0.795 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002599/1.161, allocations: 2.879 MB / 0.966 GB, free: 1.363 MB / 0.795 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001573/1.163, allocations: 155.5 kB / 0.9661 GB, free: 1.211 MB / 0.795 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.368e-05/1.163, allocations: 31.98 kB / 0.9661 GB, free: 1.18 MB / 0.795 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001722/1.165, allocations: 0.6639 MB / 0.9668 GB, free: 0.5117 MB / 0.795 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001165/1.166, allocations: 0.6509 MB / 0.9674 GB, free: 15.72 MB / 0.8106 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001538/1.167, allocations: 0.6756 MB / 0.9681 GB, free: 14.96 MB / 0.8106 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.647e-06/1.167, allocations: 0 / 0.9681 GB, free: 14.96 MB / 0.8106 GB
Notification: Performance of matching and sorting (n=72) (initialization_lambda0): time 0.002654/1.17, allocations: 0.9549 MB / 0.969 GB, free: 13.99 MB / 0.8106 GB
Notification: Performance of prepare postOptimizeDAE: time 1.734e-05/1.17, allocations: 8 kB / 0.969 GB, free: 13.98 MB / 0.8106 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.163e-05/1.17, allocations: 8 kB / 0.969 GB, free: 13.98 MB / 0.8106 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001466/1.17, allocations: 61.62 kB / 0.9691 GB, free: 13.91 MB / 0.8106 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008847/1.171, allocations: 160.1 kB / 0.9692 GB, free: 13.75 MB / 0.8106 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002478/1.174, allocations: 2.883 MB / 0.9721 GB, free: 10.66 MB / 0.8106 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001413/1.175, allocations: 123.8 kB / 0.9722 GB, free: 10.54 MB / 0.8106 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.197e-05/1.175, allocations: 35.98 kB / 0.9722 GB, free: 10.51 MB / 0.8106 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 28
 * 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 (67):
 * Single equations (assignments): 64
 * Array equations: 1
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0003058/1.175, allocations: 224 kB / 0.9724 GB, free: 10.28 MB / 0.8106 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002199/1.176, allocations: 135.1 kB / 0.9725 GB, free: 10.15 MB / 0.8106 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001804/1.178, allocations: 0.6621 MB / 0.9732 GB, free: 9.461 MB / 0.8106 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.467e-06/1.178, allocations: 0 / 0.9732 GB, free: 9.461 MB / 0.8106 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.676e-06/1.178, allocations: 4 kB / 0.9732 GB, free: 9.457 MB / 0.8106 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.752e-06/1.178, allocations: 7.922 kB / 0.9732 GB, free: 9.449 MB / 0.8106 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003137/1.181, allocations: 1.472 MB / 0.9746 GB, free: 7.918 MB / 0.8106 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.019e-06/1.181, allocations: 0 / 0.9746 GB, free: 7.918 MB / 0.8106 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000572/1.181, allocations: 79.88 kB / 0.9747 GB, free: 7.84 MB / 0.8106 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0001499/1.181, allocations: 53.81 kB / 0.9748 GB, free: 7.781 MB / 0.8106 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.946e-05/1.181, allocations: 11.98 kB / 0.9748 GB, free: 7.77 MB / 0.8106 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002558/1.184, allocations: 2.876 MB / 0.9776 GB, free: 4.695 MB / 0.8106 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.761e-06/1.184, allocations: 7.969 kB / 0.9776 GB, free: 4.688 MB / 0.8106 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001738/1.186, allocations: 0.7095 MB / 0.9783 GB, free: 3.941 MB / 0.8106 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005006/1.186, allocations: 195 kB / 0.9785 GB, free: 3.75 MB / 0.8106 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001216/1.186, allocations: 8 kB / 0.9785 GB, free: 3.742 MB / 0.8106 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008386/1.187, allocations: 51.94 kB / 0.9785 GB, free: 3.691 MB / 0.8106 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.177e-05/1.187, allocations: 31.94 kB / 0.9786 GB, free: 3.66 MB / 0.8106 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.32e-05/1.187, allocations: 15.98 kB / 0.9786 GB, free: 3.645 MB / 0.8106 GB
Notification: Performance of sorting global known variables: time 0.001729/1.189, allocations: 0.9142 MB / 0.9795 GB, free: 2.73 MB / 0.8106 GB
Notification: Performance of sort global known variables: time 1e-07/1.189, allocations: 0 / 0.9795 GB, free: 2.73 MB / 0.8106 GB
Notification: Performance of remove unused functions: time 0.002381/1.191, allocations: 0.8218 MB / 0.9803 GB, free: 1.906 MB / 0.8106 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * 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 (32):
 * Single equations (assignments): 30
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,2,100.0%), (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.000738/1.192, allocations: 302.3 kB / 0.9806 GB, free: 1.602 MB / 0.8106 GB
Notification: Performance of simCode: created initialization part: time 0.003723/1.196, allocations: 1.414 MB / 0.9819 GB, free: 140 kB / 0.8106 GB
Notification: Performance of simCode: created event and clocks part: time 5.8e-06/1.196, allocations: 0 / 0.9819 GB, free: 140 kB / 0.8106 GB
Notification: Performance of simCode: created simulation system equations: time 0.0008795/1.197, allocations: 450.5 kB / 0.9824 GB, free: 15.67 MB / 0.8262 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002928/1.2, allocations: 0.6173 MB / 0.983 GB, free: 15.07 MB / 0.8262 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005819/1.206, allocations: 2.578 MB / 0.9855 GB, free: 12.45 MB / 0.8262 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001098/1.207, allocations: 0.7598 MB / 0.9862 GB, free: 11.66 MB / 0.8262 GB
Notification: Performance of simCode: alias equations: time 0.001493/1.208, allocations: 310.7 kB / 0.9865 GB, free: 11.35 MB / 0.8262 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003271/1.208, allocations: 100.5 kB / 0.9866 GB, free: 11.25 MB / 0.8262 GB
Notification: Performance of SimCode: time 8.71e-07/1.208, allocations: 0 / 0.9866 GB, free: 11.25 MB / 0.8262 GB
Notification: Performance of Templates: time 0.04958/1.258, allocations: 25.2 MB / 1.011 GB, free: 2.484 MB / 0.8419 GB
"
[Timeout remaining time 659]
make -j1 -f IDEAS_IDEAS.Fluid.FMI.Validation.HeaterFan.makefile [Timeout 660]
(rm -f IDEAS_IDEAS.Fluid.FMI.Validation.HeaterFan.pipe ; mkfifo IDEAS_IDEAS.Fluid.FMI.Validation.HeaterFan.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.FMI.Validation.HeaterFan.pipe >> ../files/IDEAS_IDEAS.Fluid.FMI.Validation.HeaterFan.sim & ./IDEAS_IDEAS.Fluid.FMI.Validation.HeaterFan  -abortSlowSimulation -alarm=480 -s ida -lv LOG_STATS > IDEAS_IDEAS.Fluid.FMI.Validation.HeaterFan.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 7.385825284989551]
Failed to read output from testmodel.py, exit status != 0:
1.2680759199429303 1.284834822 0.174209825
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fcecb81efe0>