Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicCheckValve.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/package.mo): time 0.8427/0.8427, allocations: 153.8 MB / 172.7 MB, free: 4.973 MB / 142.1 MB " [Timeout remaining time 179] Using package ThermoSysPro with version 4.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/package.mo) Running command: "" <> buildModelFMU(ThermoSysPro.Examples.SimpleExamples.TestDynamicCheckValve,fileNamePrefix="ThermoSysPro_ThermoSysPro_Examples_SimpleExamples_TestDynamicCheckValve",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(ThermoSysPro.Examples.SimpleExamples.TestDynamicCheckValve,fileNamePrefix="ThermoSysPro_ThermoSysPro_Examples_SimpleExamples_TestDynamicCheckValve",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 0.0004733/0.0004733, allocations: 11.98 kB / 249.9 MB, free: 4.457 MB / 206.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.175/0.1754, allocations: 33.36 MB / 283.2 MB, free: 1.844 MB / 222.1 MB Notification: Automatically loaded package Complex 4.1.0 due to uses annotation from Modelica. Notification: Automatically loaded package ModelicaServices 4.1.0 due to uses annotation from Modelica. Notification: Automatically loaded package Modelica 4.1.0 due to usage. Notification: Performance of NFInst.instantiate(ThermoSysPro.Examples.SimpleExamples.TestDynamicCheckValve): time 1.798/1.973, allocations: 307.7 MB / 0.5771 GB, free: 15.89 MB / 478.1 MB Notification: Performance of NFInst.instExpressions: time 0.03702/2.01, allocations: 35.11 MB / 0.6114 GB, free: 13.94 MB / 494.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.000472/2.011, allocations: 2.25 kB / 0.6114 GB, free: 13.94 MB / 494.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/WaterSteam/BoundaryConditions/SourceP.mo:30:3-31:45:writable] Warning: Connector C is not balanced: The number of potential variables (4) is not equal to the number of flow variables (0). [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/WaterSteam/BoundaryConditions/SinkP.mo:33:3-34:47:writable] Warning: Connector C is not balanced: The number of potential variables (4) is not equal to the number of flow variables (0). [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/WaterSteam/PressureLosses/DynamicCheckValve.mo:61:3-63:16:writable] Warning: Connector C1 is not balanced: The number of potential variables (4) is not equal to the number of flow variables (0). [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/WaterSteam/PressureLosses/DynamicCheckValve.mo:64:3-65:51:writable] Warning: Connector C2 is not balanced: The number of potential variables (4) is not equal to the number of flow variables (0). Notification: Performance of NFTyping.typeComponents: time 0.0006076/2.012, allocations: 152.7 kB / 0.6115 GB, free: 13.86 MB / 494.1 MB Notification: Performance of NFTyping.typeBindings: time 0.000407/2.012, allocations: 150.9 kB / 0.6117 GB, free: 13.77 MB / 494.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/Properties/WaterSteam/IF97_packages.mo:783:9-783:27:writable] Warning: cv was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/Properties/WaterSteam/IF97_packages.mo:850:9-850:27:writable] Warning: cv was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/Properties/WaterSteam/IF97_packages.mo:1088:9-1088:27:writable] Warning: cv was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/Properties/WaterSteamSimple/prop4_Ph.mo:69:3-69:60:writable] Warning: dh1satp was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/Properties/WaterSteamSimple/prop4_Ph.mo:69:3-69:60:writable] Warning: dh2satp was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/Properties/WaterSteamSimple/prop4_Ph_der.mo:167:3-170:49:writable] Warning: du1satp_der was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/Properties/WaterSteamSimple/prop4_Ph_der.mo:167:3-170:49:writable] Warning: du2satp_der was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. Notification: Performance of NFTyping.typeClassSections: time 0.02891/2.041, allocations: 10 MB / 0.6215 GB, free: 7.941 MB / 494.1 MB Notification: Performance of NFFlatten.flatten: time 0.0008346/2.042, allocations: 451.8 kB / 0.6219 GB, free: 7.5 MB / 494.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0002449/2.042, allocations: 137.5 kB / 0.622 GB, free: 7.363 MB / 494.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0003492/2.042, allocations: 196 kB / 0.6222 GB, free: 7.172 MB / 494.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0002789/2.043, allocations: 171.2 kB / 0.6224 GB, free: 7.004 MB / 494.1 MB Notification: Performance of NFPackage.collectConstants: time 4.458e-05/2.043, allocations: 28.72 kB / 0.6224 GB, free: 6.977 MB / 494.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.03561/2.078, allocations: 17.94 MB / 0.6399 GB, free: 5.02 MB / 0.4981 GB Notification: Performance of NFScalarize.scalarize: time 0.0001634/2.078, allocations: 71.69 kB / 0.64 GB, free: 4.949 MB / 0.4981 GB Notification: Performance of NFVerifyModel.verify: time 0.0002568/2.079, allocations: 171.1 kB / 0.6401 GB, free: 4.781 MB / 0.4981 GB Notification: Performance of NFConvertDAE.convert: time 0.02205/2.101, allocations: 8.528 MB / 0.6485 GB, free: 12.23 MB / 0.5137 GB Notification: Performance of FrontEnd - DAE generated: time 6.943e-06/2.101, allocations: 3.938 kB / 0.6485 GB, free: 12.23 MB / 0.5137 GB Notification: Performance of FrontEnd: time 2.124e-06/2.101, allocations: 0 / 0.6485 GB, free: 12.23 MB / 0.5137 GB Notification: Performance of Transformations before backend: time 1.396e-05/2.101, allocations: 0 / 0.6485 GB, free: 12.23 MB / 0.5137 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 85 * Number of variables: 85 Notification: Performance of Generate backend data structure: time 0.005046/2.106, allocations: 1.568 MB / 0.65 GB, free: 10.62 MB / 0.5137 GB Notification: Performance of prepare preOptimizeDAE: time 5.035e-05/2.106, allocations: 8.031 kB / 0.65 GB, free: 10.61 MB / 0.5137 GB Notification: Performance of preOpt introduceOutputAliases (simulation): time 7.695e-05/2.106, allocations: 66.53 kB / 0.6501 GB, free: 10.54 MB / 0.5137 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0002092/2.106, allocations: 55.7 kB / 0.6501 GB, free: 10.48 MB / 0.5137 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.0003386/2.106, allocations: 208.5 kB / 0.6503 GB, free: 10.25 MB / 0.5137 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.959e-05/2.107, allocations: 71.91 kB / 0.6504 GB, free: 10.17 MB / 0.5137 GB Notification: Performance of preOpt expandDerOperator (simulation): time 4.858e-05/2.107, allocations: 24 kB / 0.6504 GB, free: 10.14 MB / 0.5137 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0005561/2.107, allocations: 363.6 kB / 0.6508 GB, free: 9.766 MB / 0.5137 GB Notification: Performance of preOpt findStateOrder (simulation): time 1.629e-05/2.107, allocations: 0 / 0.6508 GB, free: 9.766 MB / 0.5137 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 2.608e-05/2.107, allocations: 8.844 kB / 0.6508 GB, free: 9.758 MB / 0.5137 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.871e-05/2.107, allocations: 11.98 kB / 0.6508 GB, free: 9.746 MB / 0.5137 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0003937/2.108, allocations: 235.3 kB / 0.651 GB, free: 9.52 MB / 0.5137 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.01885/2.126, allocations: 6.572 MB / 0.6574 GB, free: 2.77 MB / 0.5137 GB Notification: Performance of preOpt comSubExp (simulation): time 0.0006637/2.127, allocations: 250.9 kB / 0.6577 GB, free: 2.512 MB / 0.5137 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0002022/2.127, allocations: 125.7 kB / 0.6578 GB, free: 2.387 MB / 0.5137 GB Notification: Performance of preOpt evalFunc (simulation): time 0.1576/2.285, allocations: 48.24 MB / 0.7049 GB, free: 2.098 MB / 0.5606 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0004518/2.285, allocations: 224 kB / 0.7051 GB, free: 1.859 MB / 0.5606 GB Notification: Performance of pre-optimization done (n=48): time 2.214e-06/2.285, allocations: 0 / 0.7051 GB, free: 1.859 MB / 0.5606 GB Notification: Performance of matching and sorting (n=48): time 0.001132/2.286, allocations: 496.3 kB / 0.7056 GB, free: 1.367 MB / 0.5606 GB Notification: Performance of inlineWhenForInitialization (initialization): time 5.046e-05/2.287, allocations: 85.05 kB / 0.7057 GB, free: 1.266 MB / 0.5606 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0002755/2.287, allocations: 249.9 kB / 0.7059 GB, free: 1.012 MB / 0.5606 GB Notification: Performance of collectPreVariables (initialization): time 2.783e-05/2.287, allocations: 30.45 kB / 0.7059 GB, free: 0.9766 MB / 0.5606 GB Notification: Performance of collectInitialEqns (initialization): time 0.000125/2.287, allocations: 169 kB / 0.7061 GB, free: 0.8086 MB / 0.5606 GB Notification: Performance of collectInitialBindings (initialization): time 0.0001177/2.287, allocations: 158.5 kB / 0.7062 GB, free: 0.6523 MB / 0.5606 GB Notification: Performance of simplifyInitialFunctions (initialization): time 9.861e-05/2.287, allocations: 65.92 kB / 0.7063 GB, free: 0.582 MB / 0.5606 GB Notification: Performance of setup shared object (initialization): time 0.0001484/2.287, allocations: 350.8 kB / 0.7066 GB, free: 236 kB / 0.5606 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0001902/2.287, allocations: 112.7 kB / 0.7067 GB, free: 124 kB / 0.5606 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0002484/2.288, allocations: 164.6 kB / 0.7069 GB, free: 15.95 MB / 0.5762 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.000438/2.288, allocations: 295.2 kB / 0.7072 GB, free: 15.64 MB / 0.5762 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.326e-06/2.288, allocations: 1.031 kB / 0.7072 GB, free: 15.64 MB / 0.5762 GB Notification: Performance of matching and sorting (n=55) (initialization): time 0.0008242/2.289, allocations: 430.7 kB / 0.7076 GB, free: 15.21 MB / 0.5762 GB Notification: Performance of prepare postOptimizeDAE: time 1.778e-05/2.289, allocations: 8.75 kB / 0.7076 GB, free: 15.2 MB / 0.5762 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.478e-06/2.289, allocations: 4 kB / 0.7076 GB, free: 15.2 MB / 0.5762 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.000974/2.29, allocations: 196.2 kB / 0.7078 GB, free: 15 MB / 0.5762 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0001419/2.29, allocations: 32.66 kB / 0.7078 GB, free: 14.97 MB / 0.5762 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002446/2.293, allocations: 2.334 MB / 0.7101 GB, free: 12.5 MB / 0.5762 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0002135/2.293, allocations: 39.72 kB / 0.7101 GB, free: 12.46 MB / 0.5762 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 2.663e-05/2.293, allocations: 13.25 kB / 0.7102 GB, free: 12.45 MB / 0.5762 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 5 * Number of states: 0 () * Number of discrete variables: 7 (checkValve.C2.b,checkValve.C1.a,puitsP1.C.a,sourceP1.C.b,checkValve.libre,$whenCondition1,$whenCondition2) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (22): * Single equations (assignments): 18 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 2 * 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): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 2 systems {(1,2), (1,4)} Notification: Performance of prepare postOptimizeDAE: time 0.0001714/2.293, allocations: 145.8 kB / 0.7103 GB, free: 12.29 MB / 0.5762 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 5.5e-05/2.293, allocations: 35.7 kB / 0.7103 GB, free: 12.26 MB / 0.5762 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0008312/2.294, allocations: 0.5654 MB / 0.7109 GB, free: 11.65 MB / 0.5762 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0005492/2.294, allocations: 362.2 kB / 0.7112 GB, free: 11.29 MB / 0.5762 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 2.284e-06/2.294, allocations: 0 / 0.7112 GB, free: 11.29 MB / 0.5762 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.829e-06/2.294, allocations: 0 / 0.7112 GB, free: 11.29 MB / 0.5762 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001416/2.296, allocations: 0.9452 MB / 0.7122 GB, free: 10.29 MB / 0.5762 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.31e-06/2.296, allocations: 5.25 kB / 0.7122 GB, free: 10.29 MB / 0.5762 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002877/2.296, allocations: 59.91 kB / 0.7122 GB, free: 10.23 MB / 0.5762 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0003594/2.297, allocations: 104.8 kB / 0.7123 GB, free: 10.12 MB / 0.5762 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 2.032e-05/2.297, allocations: 4 kB / 0.7123 GB, free: 10.12 MB / 0.5762 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0005417/2.297, allocations: 0.6455 MB / 0.7129 GB, free: 9.453 MB / 0.5762 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.052e-06/2.297, allocations: 0 / 0.7129 GB, free: 9.453 MB / 0.5762 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001012/2.298, allocations: 0.6593 MB / 0.7136 GB, free: 8.773 MB / 0.5762 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0001077/2.298, allocations: 59.62 kB / 0.7137 GB, free: 8.715 MB / 0.5762 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 4.234e-05/2.298, allocations: 14.02 kB / 0.7137 GB, free: 8.703 MB / 0.5762 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0001915/2.298, allocations: 16.86 kB / 0.7137 GB, free: 8.688 MB / 0.5762 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 8.449e-05/2.299, allocations: 31.94 kB / 0.7137 GB, free: 8.656 MB / 0.5762 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 2.687e-05/2.299, allocations: 11.98 kB / 0.7137 GB, free: 8.645 MB / 0.5762 GB Notification: Performance of sorting global known variables: time 0.0002331/2.299, allocations: 223 kB / 0.7139 GB, free: 8.43 MB / 0.5762 GB Notification: Performance of sort global known variables: time 6e-08/2.299, allocations: 0 / 0.7139 GB, free: 8.43 MB / 0.5762 GB Notification: Performance of remove unused functions: time 0.003378/2.302, allocations: 1.235 MB / 0.7151 GB, free: 7.191 MB / 0.5762 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 1 * Number of states: 2 (checkValve.omega,checkValve.theta) * Number of discrete variables: 3 ($whenCondition2,$whenCondition1,checkValve.libre) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (30): * Single equations (assignments): 28 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 1 * 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): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(1,3)} Notification: Performance of Backend phase and start with SimCode phase: time 0.007232/2.309, allocations: 2.844 MB / 0.7179 GB, free: 4.355 MB / 0.5762 GB Notification: Performance of simCode: created initialization part: time 0.00118/2.311, allocations: 472.7 kB / 0.7184 GB, free: 3.875 MB / 0.5762 GB Notification: Performance of simCode: created event and clocks part: time 3.527e-06/2.311, allocations: 0 / 0.7184 GB, free: 3.875 MB / 0.5762 GB Notification: Performance of simCode: created simulation system equations: time 0.0004203/2.311, allocations: 183.2 kB / 0.7185 GB, free: 3.699 MB / 0.5762 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0008086/2.312, allocations: 135.3 kB / 0.7187 GB, free: 3.586 MB / 0.5762 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006835/2.319, allocations: 3.874 MB / 0.7225 GB, free: 15.6 MB / 0.5919 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004443/2.319, allocations: 0.804 MB / 0.7232 GB, free: 14.77 MB / 0.5919 GB Notification: Performance of simCode: alias equations: time 0.0001617/2.319, allocations: 33.33 kB / 0.7233 GB, free: 14.74 MB / 0.5919 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001926/2.319, allocations: 135.4 kB / 0.7234 GB, free: 14.61 MB / 0.5919 GB Notification: Performance of SimCode: time 1.172e-06/2.319, allocations: 0 / 0.7234 GB, free: 14.61 MB / 0.5919 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.09914/2.419, allocations: 50.68 MB / 0.7729 GB, free: 12.56 MB / 0.6387 GB Notification: Performance of buildModelFMU: Generate platform static: time 14.55/16.96, allocations: 8.562 kB / 0.7729 GB, free: 12.56 MB / 0.6387 GB " [Timeout remaining time 643] (rm -f ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicCheckValve.pipe ; mkfifo ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicCheckValve.pipe ; head -c 1048576 < ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicCheckValve.pipe >> ../files/ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicCheckValve.sim & python3 -m fmpy simulate --output-file ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicCheckValve_res.csv --start-time 0 --stop-time 300 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.12 ThermoSysPro_ThermoSysPro_Examples_SimpleExamples_TestDynamicCheckValve.fmu > ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicCheckValve.pipe 2>&1) [Timeout 52.5] [Calling sys.exit(0), Time elapsed: 19.939870851000023] Failed to read output from testmodel.py, exit status != 0: 17.473787152999876 17.484449273 15.381086234 Calling exit ...