Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo): time 0.04223/0.04223, allocations: 9.127 MB / 18.91 MB, free: 0.7148 MB / 18.57 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.00501/0.04724, allocations: 3.409 MB / 22.32 MB, free: 3.801 MB / 24.77 MB
"
[Timeout remaining time 180]
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.001039/0.001039, allocations: 79.16 kB / 23.15 MB, free: 2.984 MB / 24.77 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.001751/0.00279, allocations: 458.5 kB / 23.6 MB, free: 2.539 MB / 24.77 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.001138/0.001138, allocations: 156.9 kB / 24.48 MB, free: 1.66 MB / 24.77 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.001478/0.002616, allocations: 474.5 kB / 24.94 MB, free: 1.195 MB / 24.77 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.9488/0.9488, allocations: 177.2 MB / 202.8 MB, free: 8.352 MB / 202.7 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.1387/1.087, allocations: 53.66 MB / 256.5 MB, free: 5.379 MB / 250.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF 0.4.5/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF 0.4.5/package.mo): time 0.003798/0.003798, allocations: 0.8256 MB / 258.1 MB, free: 3.938 MB / 250.7 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.001551/0.005348, allocations: 0.6472 MB / 258.7 MB, free: 3.285 MB / 250.7 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.1/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.1/package.mo): time 1.687/1.687, allocations: 274.9 MB / 0.5218 GB, free: 1.113 MB / 0.4949 GB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.1359/1.823, allocations: 78.9 MB / 0.5989 GB, free: 2.242 MB / 0.573 GB
"
[Timeout remaining time 178]
Using package AixLib with version 3.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.1/package.mo)
Using package SDF with version 0.4.5 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF 0.4.5/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)
Using package Modelica_DeviceDrivers with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo)
Running command: setCommandLineOptions("--fmiFlags=s:cvode")
Running command: "" <> buildModelFMU(AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem,fileNamePrefix="AixLib_AixLib_Fluid_Movers_Validation_FlowControlled_dpSystem",fmuType="me_cs",version="2.0+3.0",platforms={"static"})
"" <> buildModelFMU(AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem,fileNamePrefix="AixLib_AixLib_Fluid_Movers_Validation_FlowControlled_dpSystem",fmuType="me_cs",version="2.0+3.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.523e-06/1.523e-06, allocations: 3.938 kB / 0.6001 GB, free: 0.9609 MB / 0.573 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.666e-05/1.818e-05, allocations: 4.844 kB / 0.6001 GB, free: 0.957 MB / 0.573 GB
Notification: Performance of NFInst.instantiate(AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem): time 0.171/0.171, allocations: 172.4 MB / 0.7685 GB, free: 3.938 MB / 0.7449 GB
Notification: Performance of NFInst.instExpressions: time 0.0257/0.1967, allocations: 16.3 MB / 0.7844 GB, free: 3.602 MB / 0.7605 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005555/0.2022, allocations: 253.9 kB / 0.7846 GB, free: 3.352 MB / 0.7605 GB
Notification: Performance of NFTyping.typeComponents: time 0.005045/0.2073, allocations: 2.276 MB / 0.7869 GB, free: 1.062 MB / 0.7605 GB
Notification: Performance of NFTyping.typeBindings: time 0.3249/0.5322, allocations: 4.986 MB / 0.7917 GB, free: 5.789 MB / 0.7605 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007563/0.5397, allocations: 4.036 MB / 0.7957 GB, free: 5.754 MB / 0.7605 GB
Notification: Performance of NFFlatten.flatten: time 0.02056/0.5603, allocations: 18.94 MB / 0.8142 GB, free: 3.887 MB / 0.7605 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.005182/0.5655, allocations: 3.704 MB / 0.8178 GB, free: 3.406 MB / 0.7605 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01021/0.5757, allocations: 7.621 MB / 0.8252 GB, free: 2.543 MB / 0.7605 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004569/0.5803, allocations: 3.395 MB / 0.8285 GB, free: 2.156 MB / 0.7605 GB
Notification: Performance of NFPackage.collectConstants: time 0.0009516/0.5812, allocations: 465.1 kB / 0.829 GB, free: 2.156 MB / 0.7605 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002913/0.5841, allocations: 1.538 MB / 0.8305 GB, free: 2.098 MB / 0.7605 GB
Notification: Performance of NFScalarize.scalarize: time 0.001653/0.5858, allocations: 1.939 MB / 0.8324 GB, free: 1.828 MB / 0.7605 GB
Notification: Performance of NFVerifyModel.verify: time 0.002755/0.5885, allocations: 1.757 MB / 0.8341 GB, free: 1.609 MB / 0.7605 GB
Notification: Performance of NFConvertDAE.convert: time 0.005794/0.5943, allocations: 4.875 MB / 0.8389 GB, free: 0.8164 MB / 0.7605 GB
Notification: Performance of FrontEnd - DAE generated: time 1.597e-05/0.5943, allocations: 2.719 kB / 0.8389 GB, free: 0.8164 MB / 0.7605 GB
Notification: Performance of FrontEnd: time 1.293e-06/0.5943, allocations: 4.906 kB / 0.8389 GB, free: 0.8125 MB / 0.7605 GB
Notification: Performance of Transformations before backend: time 0.0001602/0.5945, allocations: 0 / 0.8389 GB, free: 0.8125 MB / 0.7605 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 719
 * Number of variables: 719
Notification: Performance of Generate backend data structure: time 0.009574/0.6041, allocations: 7.447 MB / 0.8461 GB, free: 13.93 MB / 0.7762 GB
Notification: Performance of prepare preOptimizeDAE: time 4.573e-05/0.6041, allocations: 9.531 kB / 0.8462 GB, free: 13.93 MB / 0.7762 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0003861/0.6045, allocations: 414.3 kB / 0.8465 GB, free: 13.88 MB / 0.7762 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006315/0.6108, allocations: 1.898 MB / 0.8484 GB, free: 13.69 MB / 0.7762 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006333/0.6172, allocations: 4.127 MB / 0.8524 GB, free: 12.5 MB / 0.7762 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001553/0.6173, allocations: 241.1 kB / 0.8527 GB, free: 12.49 MB / 0.7762 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004097/0.6177, allocations: 328.7 kB / 0.853 GB, free: 12.49 MB / 0.7762 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00326/0.621, allocations: 2.879 MB / 0.8558 GB, free: 11.29 MB / 0.7762 GB
Notification: Performance of preOpt findStateOrder (simulation): time 6.132e-05/0.6211, allocations: 11.19 kB / 0.8558 GB, free: 11.29 MB / 0.7762 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002185/0.6213, allocations: 119.2 kB / 0.8559 GB, free: 11.29 MB / 0.7762 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.082e-05/0.6214, allocations: 105 kB / 0.856 GB, free: 11.28 MB / 0.7762 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001567/0.6229, allocations: 0.9268 MB / 0.8569 GB, free: 11.19 MB / 0.7762 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.0115/0.6344, allocations: 9.842 MB / 0.8665 GB, free: 6.922 MB / 0.7762 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001322/0.6357, allocations: 1.001 MB / 0.8675 GB, free: 6.805 MB / 0.7762 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005839/0.6363, allocations: 416.4 kB / 0.8679 GB, free: 6.789 MB / 0.7762 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001593/0.6365, allocations: 61.48 kB / 0.868 GB, free: 6.789 MB / 0.7762 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.024e-05/0.6365, allocations: 65.69 kB / 0.868 GB, free: 6.746 MB / 0.7762 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001116/0.6376, allocations: 314.2 kB / 0.8683 GB, free: 6.637 MB / 0.7762 GB
Notification: Performance of pre-optimization done (n=181): time 4.278e-06/0.6376, allocations: 3.5 kB / 0.8683 GB, free: 6.637 MB / 0.7762 GB
Notification: Performance of matching and sorting (n=189): time 0.005967/0.6436, allocations: 2.96 MB / 0.8712 GB, free: 6.211 MB / 0.7762 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.128e-05/0.6436, allocations: 78.84 kB / 0.8713 GB, free: 6.145 MB / 0.7762 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003488/0.6471, allocations: 3.873 MB / 0.8751 GB, free: 5.238 MB / 0.7762 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001372/0.6473, allocations: 79.05 kB / 0.8751 GB, free: 5.188 MB / 0.7762 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008421/0.6481, allocations: 1.4 MB / 0.8765 GB, free: 4.285 MB / 0.7762 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0004219/0.6485, allocations: 0.681 MB / 0.8772 GB, free: 3.75 MB / 0.7762 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005662/0.6491, allocations: 459.2 kB / 0.8776 GB, free: 3.535 MB / 0.7762 GB
Notification: Performance of setup shared object (initialization): time 6.556e-05/0.6492, allocations: 306 kB / 0.8779 GB, free: 3.234 MB / 0.7762 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005107/0.6497, allocations: 283.1 kB / 0.8782 GB, free: 2.996 MB / 0.7762 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001295/0.651, allocations: 2.525 MB / 0.8806 GB, free: 15.9 MB / 0.7918 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: zone2.dynBal.medium.p = zone2.dynBal.p_start (sin.p = zone2.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: zone1.dynBal.medium.p = zone1.dynBal.p_start (sin.p = zone1.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: zone3.dynBal.medium.p = zone3.dynBal.p_start (sin.p = zone3.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: zone4.dynBal.medium.p = zone4.dynBal.p_start (sin.p = zone4.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.003064/0.654, allocations: 2.972 MB / 0.8835 GB, free: 13.18 MB / 0.7918 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.246e-06/0.654, allocations: 8 kB / 0.8836 GB, free: 13.18 MB / 0.7918 GB
Notification: Performance of matching and sorting (n=288) (initialization): time 0.00207/0.6561, allocations: 1.633 MB / 0.8852 GB, free: 12.06 MB / 0.7918 GB
Notification: Performance of prepare postOptimizeDAE: time 1.964e-05/0.6561, allocations: 18.19 kB / 0.8852 GB, free: 12.04 MB / 0.7918 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.924e-05/0.6562, allocations: 20 kB / 0.8852 GB, free: 12.02 MB / 0.7918 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001135/0.6573, allocations: 457.5 kB / 0.8856 GB, free: 11.66 MB / 0.7918 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001242/0.6585, allocations: 0.5863 MB / 0.8862 GB, free: 11.13 MB / 0.7918 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0006502/0.6592, allocations: 1.703 MB / 0.8879 GB, free: 9.398 MB / 0.7918 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00157/0.6608, allocations: 181.5 kB / 0.888 GB, free: 9.266 MB / 0.7918 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001333/0.6609, allocations: 90.33 kB / 0.8881 GB, free: 9.195 MB / 0.7918 GB
Warning: The initial conditions are over specified. The following 4 initial equations are redundant, so they are removed from the initialization system:
         zone2.dynBal.medium.p = zone2.dynBal.p_start
         zone1.dynBal.medium.p = zone1.dynBal.p_start
         zone3.dynBal.medium.p = zone3.dynBal.p_start
         zone4.dynBal.medium.p = zone4.dynBal.p_start.
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0008401/0.6617, allocations: 402.2 kB / 0.8885 GB, free: 8.84 MB / 0.7918 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001138/0.6629, allocations: 2.522 MB / 0.891 GB, free: 5.656 MB / 0.7918 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: zone2.dynBal.medium.p = zone2.dynBal.p_start (sin.p = zone2.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: zone1.dynBal.medium.p = zone1.dynBal.p_start (sin.p = zone1.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: zone3.dynBal.medium.p = zone3.dynBal.p_start (sin.p = zone3.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: zone4.dynBal.medium.p = zone4.dynBal.p_start (sin.p = zone4.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002791/0.6657, allocations: 2.842 MB / 0.8937 GB, free: 2.723 MB / 0.7918 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 9.017e-06/0.6657, allocations: 4 kB / 0.8937 GB, free: 2.719 MB / 0.7918 GB
Notification: Performance of matching and sorting (n=288) (initialization_lambda0): time 0.001793/0.6675, allocations: 1.574 MB / 0.8953 GB, free: 1.328 MB / 0.7918 GB
Notification: Performance of prepare postOptimizeDAE: time 1.561e-05/0.6675, allocations: 16.88 kB / 0.8953 GB, free: 1.312 MB / 0.7918 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.455e-05/0.6675, allocations: 20 kB / 0.8953 GB, free: 1.293 MB / 0.7918 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003951/0.6679, allocations: 219 kB / 0.8955 GB, free: 1.086 MB / 0.7918 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001172/0.6691, allocations: 0.5681 MB / 0.8961 GB, free: 0.5625 MB / 0.7918 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002582/0.6716, allocations: 4.683 MB / 0.9007 GB, free: 11.8 MB / 0.8074 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00171/0.6733, allocations: 214 kB / 0.9009 GB, free: 11.64 MB / 0.8074 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001254/0.6735, allocations: 85.89 kB / 0.9009 GB, free: 11.57 MB / 0.8074 GB
Warning: The initial conditions are over specified. The following 4 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         zone2.dynBal.medium.p = zone2.dynBal.p_start
         zone1.dynBal.medium.p = zone1.dynBal.p_start
         zone3.dynBal.medium.p = zone3.dynBal.p_start
         zone4.dynBal.medium.p = zone4.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 90
 * 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 (270):
 * Single equations (assignments): 265
 * Array equations: 2
 * Algorithm blocks: 0
 * 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,9), (1,3), (1,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003752/0.6738, allocations: 363.2 kB / 0.9013 GB, free: 11.31 MB / 0.8074 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003868/0.6742, allocations: 352.7 kB / 0.9016 GB, free: 10.99 MB / 0.8074 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0017/0.6759, allocations: 1.403 MB / 0.903 GB, free: 9.828 MB / 0.8074 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.233e-05/0.6759, allocations: 23.94 kB / 0.903 GB, free: 9.805 MB / 0.8074 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.743e-06/0.6759, allocations: 0 / 0.903 GB, free: 9.805 MB / 0.8074 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00101/0.677, allocations: 0.9155 MB / 0.9039 GB, free: 8.855 MB / 0.8074 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006745/0.6837, allocations: 3.845 MB / 0.9077 GB, free: 5.699 MB / 0.8074 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.015e-05/0.6837, allocations: 12 kB / 0.9077 GB, free: 5.688 MB / 0.8074 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001492/0.6852, allocations: 0.6507 MB / 0.9083 GB, free: 5.141 MB / 0.8074 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001592/0.6868, allocations: 0.5838 MB / 0.9089 GB, free: 4.605 MB / 0.8074 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0004173/0.6872, allocations: 173.5 kB / 0.909 GB, free: 4.445 MB / 0.8074 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.952e-05/0.6873, allocations: 47.48 kB / 0.9091 GB, free: 4.426 MB / 0.8074 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0006564/0.688, allocations: 1.672 MB / 0.9107 GB, free: 2.719 MB / 0.8074 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 8.896e-06/0.688, allocations: 15.09 kB / 0.9107 GB, free: 2.707 MB / 0.8074 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00229/0.6903, allocations: 2.031 MB / 0.9127 GB, free: 0.6602 MB / 0.8074 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005461/0.6908, allocations: 47.73 kB / 0.9128 GB, free: 0.6406 MB / 0.8074 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001379/0.6922, allocations: 116.2 kB / 0.9129 GB, free: 0.5547 MB / 0.8074 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000183/0.6924, allocations: 149.8 kB / 0.913 GB, free: 440 kB / 0.8074 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001037/0.6925, allocations: 63.39 kB / 0.9131 GB, free: 392 kB / 0.8074 GB
Notification: Performance of sorting global known variables: time 0.001688/0.6942, allocations: 1.936 MB / 0.915 GB, free: 14.79 MB / 0.823 GB
Notification: Performance of sort global known variables: time 4.5e-07/0.6942, allocations: 0 / 0.915 GB, free: 14.79 MB / 0.823 GB
Notification: Performance of remove unused functions: time 0.003298/0.6975, allocations: 1.878 MB / 0.9168 GB, free: 13.02 MB / 0.823 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 37
 * Number of states: 8 (zone2.dynBal.medium.Xi[1],zone2.dynBal.U,zone1.dynBal.medium.Xi[1],zone1.dynBal.U,zone3.dynBal.medium.Xi[1],zone3.dynBal.U,zone4.dynBal.medium.Xi[1],zone4.dynBal.U)
 * 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 (185):
 * Single equations (assignments): 182
 * Array equations: 0
 * Algorithm blocks: 0
 * 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,9), (1,3), (1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.002477/0.6999, allocations: 2.641 MB / 0.9194 GB, free: 10.41 MB / 0.823 GB
Notification: Performance of simCode: created initialization part: time 0.002685/0.7026, allocations: 2.273 MB / 0.9216 GB, free: 8.395 MB / 0.823 GB
Notification: Performance of simCode: created event and clocks part: time 5.196e-05/0.7027, allocations: 58.31 kB / 0.9217 GB, free: 8.34 MB / 0.823 GB
Notification: Performance of simCode: created simulation system equations: time 0.0006085/0.7033, allocations: 0.565 MB / 0.9222 GB, free: 7.871 MB / 0.823 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.006528/0.7098, allocations: 3.491 MB / 0.9256 GB, free: 4.941 MB / 0.823 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0222/0.732, allocations: 20.04 MB / 0.9452 GB, free: 2.418 MB / 0.8387 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0008965/0.7329, allocations: 1.024 MB / 0.9462 GB, free: 1.469 MB / 0.8387 GB
Notification: Performance of simCode: alias equations: time 0.003592/0.7365, allocations: 0.9638 MB / 0.9471 GB, free: 0.5 MB / 0.8387 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.005909/0.7424, allocations: 3.772 MB / 0.9508 GB, free: 12.81 MB / 0.8543 GB
Notification: Performance of SimCode: time 1.593e-06/0.7424, allocations: 0 / 0.9508 GB, free: 12.81 MB / 0.8543 GB
Notification: Performance of FMU documentation: time 0.1832/0.9256, allocations: 188.8 MB / 1.135 GB, free: 13.18 MB / 1.042 GB
Notification: FMU-only work: backend 0.001972, simCode 0.01189, templates 0
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.06668/0.9923, allocations: 1.337 MB / 1.136 GB, free: 11.82 MB / 1.042 GB
Notification: Building FMU for platform 'static' (1/1).
Notification: Finished FMU for platform 'static' (1/1).
Notification: Performance of buildModelFMU: Generate platform static: time 5.381/6.373, allocations: 21.77 kB / 1.137 GB, free: 11.8 MB / 1.042 GB
"
[Timeout remaining time 654]
(rm -f AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem.pipe ; mkfifo AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem.pipe ; head -c 1048576 < AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem.pipe >> ../files/AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem.sim & (cd run_OMSimulator && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --stripRoot --tempDir=temp_AixLib_AixLib_Fluid_Movers_Validation_FlowControlled_dpSystem_fmu --startTime=0 --stopTime=1 --stepSize=0.0004 --mode=me --timeout=240 --tolerance=1e-06 ../AixLib_AixLib_Fluid_Movers_Validation_FlowControlled_dpSystem.fmu) > AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem.pipe 2>&1) [Timeout 252.0]
(rm -f AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_OMSimulator-cs-cvode.pipe ; mkfifo AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_OMSimulator-cs-cvode.pipe ; head -c 1048576 < AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_OMSimulator-cs-cvode.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_OMSimulator-cs-cvode.sim & (cd run_OMSimulator-cs-cvode && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --stripRoot --tempDir=temp_AixLib_AixLib_Fluid_Movers_Validation_FlowControlled_dpSystem_OMSimulator-cs-cvode_fmu --startTime=0 --stopTime=1 --stepSize=0.0004 --mode=cs --timeout=240 --tolerance=1e-06 ../AixLib_AixLib_Fluid_Movers_Validation_FlowControlled_dpSystem_OMSimulator-cs-cvode.fmu) > AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_OMSimulator-cs-cvode.pipe 2>&1) [Timeout 252.0]
(rm -f AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_OMSimulator-cs-euler.pipe ; mkfifo AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_OMSimulator-cs-euler.pipe ; head -c 1048576 < AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_OMSimulator-cs-euler.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_OMSimulator-cs-euler.sim & (cd run_OMSimulator-cs-euler && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --stripRoot --tempDir=temp_AixLib_AixLib_Fluid_Movers_Validation_FlowControlled_dpSystem_OMSimulator-cs-euler_fmu --startTime=0 --stopTime=1 --stepSize=0.0004 --mode=cs --timeout=240 --tolerance=1e-06 ../AixLib_AixLib_Fluid_Movers_Validation_FlowControlled_dpSystem_OMSimulator-cs-euler.fmu) > AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_OMSimulator-cs-euler.pipe 2>&1) [Timeout 252.0]
(rm -f AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy.pipe ; mkfifo AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy.pipe ; head -c 1048576 < AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy.sim & (cd run_fmpy && python3 -m fmpy simulate --output-file ../AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy_res.csv --start-time 0 --stop-time 1 --timeout 240 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.0004 ../AixLib_AixLib_Fluid_Movers_Validation_FlowControlled_dpSystem.fmu) > AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy.pipe 2>&1) [Timeout 252.0]
(rm -f AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy-fmi3-cs-cvode.pipe ; mkfifo AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy-fmi3-cs-cvode.pipe ; head -c 1048576 < AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy-fmi3-cs-cvode.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy-fmi3-cs-cvode.sim & (cd run_fmpy-fmi3-cs-cvode && python3 -m fmpy simulate --output-file ../AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy-fmi3-cs-cvode_res.csv --start-time 0 --stop-time 1 --timeout 240 --relative-tolerance 1e-06 --interface-type CoSimulation --output-interval 0.0004 ../AixLib_AixLib_Fluid_Movers_Validation_FlowControlled_dpSystem_fmpy-fmi3-cs-cvode.fmu) > AixLib_AixLib.Fluid.Movers.Validation.FlowControlled_dpSystem_fmpy-fmi3-cs-cvode.pipe 2>&1) [Timeout 252.0]
[Calling sys.exit(0), Time elapsed: 11.26423873193562]