Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDiaphragm.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.8527/0.8527, allocations: 153.8 MB / 170.9 MB, free: 13.7 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.TestDiaphragm,fileNamePrefix="ThermoSysPro_ThermoSysPro_Examples_SimpleExamples_TestDiaphragm",fmuType="cs",version="2.0",platforms={"static"}) "" <> buildModelFMU(ThermoSysPro.Examples.SimpleExamples.TestDiaphragm,fileNamePrefix="ThermoSysPro_ThermoSysPro_Examples_SimpleExamples_TestDiaphragm",fmuType="cs",version="2.0",platforms={"static"}) [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 0.0004934/0.0004934, allocations: 21.39 kB / 247 MB, free: 14.86 MB / 206.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.06416/0.06465, allocations: 33.33 MB / 280.4 MB, free: 15.12 MB / 238.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.TestDiaphragm): time 1.741/1.806, allocations: 307.3 MB / 0.5739 GB, free: 10.54 MB / 462.1 MB Notification: Performance of NFInst.instExpressions: time 0.04304/1.849, allocations: 34.9 MB / 0.608 GB, free: 7.5 MB / 494.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0002121/1.849, allocations: 4 kB / 0.608 GB, free: 7.496 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/Diaphragm.mo:30:3-32:42: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/Diaphragm.mo:33:3-35:37: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.0003981/1.85, allocations: 135.9 kB / 0.6081 GB, free: 7.363 MB / 494.1 MB Notification: Performance of NFTyping.typeBindings: time 0.0002078/1.85, allocations: 111.2 kB / 0.6082 GB, free: 7.254 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.02489/1.875, allocations: 9.817 MB / 0.6178 GB, free: 13.42 MB / 0.4981 GB Notification: Performance of NFFlatten.flatten: time 0.0005803/1.875, allocations: 358.8 kB / 0.6181 GB, free: 13.07 MB / 0.4981 GB Notification: Performance of NFFlatten.resolveConnections: time 0.0001957/1.876, allocations: 92.66 kB / 0.6182 GB, free: 12.98 MB / 0.4981 GB Notification: Performance of NFEvalConstants.evaluate: time 0.000271/1.876, allocations: 159.3 kB / 0.6184 GB, free: 12.82 MB / 0.4981 GB Notification: Performance of NFSimplifyModel.simplify: time 0.0001752/1.876, allocations: 111.4 kB / 0.6185 GB, free: 12.71 MB / 0.4981 GB Notification: Performance of NFPackage.collectConstants: time 3.314e-05/1.876, allocations: 23.94 kB / 0.6185 GB, free: 12.69 MB / 0.4981 GB Notification: Performance of NFFlatten.collectFunctions: time 0.03292/1.909, allocations: 17.98 MB / 0.6361 GB, free: 10.69 MB / 0.5137 GB Notification: Performance of NFScalarize.scalarize: time 9.826e-05/1.909, allocations: 47.77 kB / 0.6361 GB, free: 10.64 MB / 0.5137 GB Notification: Performance of NFVerifyModel.verify: time 0.0002186/1.909, allocations: 135.4 kB / 0.6362 GB, free: 10.51 MB / 0.5137 GB Notification: Performance of NFConvertDAE.convert: time 0.02218/1.931, allocations: 8.501 MB / 0.6445 GB, free: 1.984 MB / 0.5137 GB Notification: Performance of FrontEnd - DAE generated: time 6.592e-06/1.932, allocations: 0 / 0.6445 GB, free: 1.984 MB / 0.5137 GB Notification: Performance of FrontEnd: time 1.894e-06/1.932, allocations: 0 / 0.6445 GB, free: 1.984 MB / 0.5137 GB Notification: Performance of Transformations before backend: time 1.365e-05/1.932, allocations: 4 kB / 0.6446 GB, free: 1.98 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: 78 * Number of variables: 78 Notification: Performance of Generate backend data structure: time 0.004903/1.936, allocations: 1.506 MB / 0.646 GB, free: 428 kB / 0.5137 GB Notification: Performance of prepare preOptimizeDAE: time 4.806e-05/1.936, allocations: 11.97 kB / 0.646 GB, free: 416 kB / 0.5137 GB Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 2.159e-05/1.936, allocations: 8.438 kB / 0.646 GB, free: 408 kB / 0.5137 GB Notification: Performance of preOpt introduceOutputAliases (simulation): time 7.492e-05/1.937, allocations: 62.53 kB / 0.6461 GB, free: 336 kB / 0.5137 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 8.08e-05/1.937, allocations: 35.77 kB / 0.6461 GB, free: 300 kB / 0.5137 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.0002785/1.937, allocations: 233.9 kB / 0.6464 GB, free: 28 kB / 0.5137 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.373e-05/1.937, allocations: 16.44 kB / 0.6464 GB, free: 12 kB / 0.5137 GB Notification: Performance of preOpt expandDerOperator (simulation): time 5.337e-05/1.937, allocations: 20.05 kB / 0.6464 GB, free: 15.99 MB / 0.5294 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0005089/1.938, allocations: 321 kB / 0.6467 GB, free: 15.64 MB / 0.5294 GB Notification: Performance of preOpt findStateOrder (simulation): time 1.114e-05/1.938, allocations: 0 / 0.6467 GB, free: 15.64 MB / 0.5294 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 2.158e-05/1.938, allocations: 4 kB / 0.6467 GB, free: 15.64 MB / 0.5294 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.959e-05/1.938, allocations: 19.98 kB / 0.6467 GB, free: 15.62 MB / 0.5294 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0002929/1.938, allocations: 174.3 kB / 0.6469 GB, free: 15.45 MB / 0.5294 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.0417/1.98, allocations: 18.16 MB / 0.6646 GB, free: 11.41 MB / 0.545 GB Notification: Performance of preOpt comSubExp (simulation): time 0.0005101/1.98, allocations: 134.5 kB / 0.6648 GB, free: 11.27 MB / 0.545 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0001075/1.98, allocations: 64.84 kB / 0.6648 GB, free: 11.21 MB / 0.545 GB Notification: Performance of preOpt evalFunc (simulation): time 0.3538/2.334, allocations: 83.05 MB / 0.7459 GB, free: 195.7 MB / 0.5919 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.8e-05/2.334, allocations: 34.31 kB / 0.746 GB, free: 195.7 MB / 0.5919 GB Notification: Performance of pre-optimization done (n=34): time 2.956e-06/2.334, allocations: 3.969 kB / 0.746 GB, free: 195.7 MB / 0.5919 GB Notification: Performance of matching and sorting (n=34): time 0.0008651/2.335, allocations: 411.1 kB / 0.7464 GB, free: 195.5 MB / 0.5919 GB Notification: Performance of inlineWhenForInitialization (initialization): time 3.385e-05/2.335, allocations: 84.98 kB / 0.7464 GB, free: 195.4 MB / 0.5919 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0001792/2.335, allocations: 228.7 kB / 0.7466 GB, free: 195.3 MB / 0.5919 GB Notification: Performance of collectPreVariables (initialization): time 1.328e-05/2.335, allocations: 29.58 kB / 0.7467 GB, free: 195.2 MB / 0.5919 GB Notification: Performance of collectInitialEqns (initialization): time 7.046e-05/2.335, allocations: 157.9 kB / 0.7468 GB, free: 195.1 MB / 0.5919 GB Notification: Performance of collectInitialBindings (initialization): time 4.959e-05/2.335, allocations: 111.9 kB / 0.7469 GB, free: 195.1 MB / 0.5919 GB Notification: Performance of simplifyInitialFunctions (initialization): time 6.586e-05/2.335, allocations: 54.89 kB / 0.747 GB, free: 195 MB / 0.5919 GB Notification: Performance of setup shared object (initialization): time 6.015e-05/2.335, allocations: 333 kB / 0.7473 GB, free: 194.7 MB / 0.5919 GB Notification: Performance of preBalanceInitialSystem (initialization): time 9.509e-05/2.335, allocations: 75.78 kB / 0.7474 GB, free: 194.7 MB / 0.5919 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0001175/2.336, allocations: 137.6 kB / 0.7475 GB, free: 194.6 MB / 0.5919 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.0002172/2.336, allocations: 241.8 kB / 0.7477 GB, free: 194.6 MB / 0.5919 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.545e-06/2.336, allocations: 0 / 0.7477 GB, free: 194.6 MB / 0.5919 GB Notification: Performance of matching and sorting (n=44) (initialization): time 0.000356/2.336, allocations: 291.8 kB / 0.748 GB, free: 194.5 MB / 0.5919 GB Notification: Performance of prepare postOptimizeDAE: time 1.641e-05/2.336, allocations: 7.75 kB / 0.748 GB, free: 194.5 MB / 0.5919 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.362e-06/2.336, allocations: 0 / 0.748 GB, free: 194.5 MB / 0.5919 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0008991/2.337, allocations: 132.5 kB / 0.7482 GB, free: 194.5 MB / 0.5919 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 7.161e-05/2.337, allocations: 19.08 kB / 0.7482 GB, free: 194.4 MB / 0.5919 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0003816/2.337, allocations: 0.6198 MB / 0.7488 GB, free: 193.9 MB / 0.5919 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0001349/2.338, allocations: 29.64 kB / 0.7488 GB, free: 193.9 MB / 0.5919 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 1.526e-05/2.338, allocations: 11.67 kB / 0.7488 GB, free: 193.9 MB / 0.5919 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 6 * Number of states: 0 () * Number of discrete variables: 4 (Diaphragm.C2.b,Diaphragm.C1.a,PuitsP1.C.a,SourceP1.C.b) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (15): * Single equations (assignments): 12 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 2 * 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,2)} Notification: Performance of prepare postOptimizeDAE: time 9.842e-05/2.338, allocations: 137.2 kB / 0.7489 GB, free: 193.8 MB / 0.5919 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 4.338e-05/2.338, allocations: 23.73 kB / 0.749 GB, free: 193.8 MB / 0.5919 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0007627/2.339, allocations: 0.5955 MB / 0.7495 GB, free: 193.4 MB / 0.5919 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.000465/2.339, allocations: 223.4 kB / 0.7498 GB, free: 193.4 MB / 0.5919 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 5.41e-06/2.339, allocations: 0 / 0.7498 GB, free: 193.4 MB / 0.5919 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.438e-06/2.339, allocations: 3.984 kB / 0.7498 GB, free: 193.4 MB / 0.5919 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00088/2.34, allocations: 0.7287 MB / 0.7505 GB, free: 192.9 MB / 0.5919 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.004e-06/2.34, allocations: 0 / 0.7505 GB, free: 192.9 MB / 0.5919 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 6.088e-05/2.34, allocations: 26.98 kB / 0.7505 GB, free: 192.9 MB / 0.5919 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0003147/2.34, allocations: 103.8 kB / 0.7506 GB, free: 192.9 MB / 0.5919 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 1.107e-05/2.34, allocations: 7.031 kB / 0.7506 GB, free: 192.9 MB / 0.5919 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0003315/2.341, allocations: 0.6441 MB / 0.7512 GB, free: 192.3 MB / 0.5919 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 9.42e-07/2.341, allocations: 0 / 0.7512 GB, free: 192.3 MB / 0.5919 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.000508/2.341, allocations: 331.4 kB / 0.7516 GB, free: 192.2 MB / 0.5919 GB Notification: Performance of postOpt removeConstants (simulation): time 5.59e-05/2.341, allocations: 116.8 kB / 0.7517 GB, free: 192 MB / 0.5919 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 3.582e-05/2.341, allocations: 6.031 kB / 0.7517 GB, free: 192 MB / 0.5919 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0001224/2.341, allocations: 11.39 kB / 0.7517 GB, free: 192 MB / 0.5919 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 4.315e-05/2.341, allocations: 7.953 kB / 0.7517 GB, free: 192 MB / 0.5919 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.716e-06/2.341, allocations: 4.562 kB / 0.7517 GB, free: 192 MB / 0.5919 GB Notification: Performance of sorting global known variables: time 0.0001808/2.342, allocations: 239.5 kB / 0.7519 GB, free: 191.9 MB / 0.5919 GB Notification: Performance of sort global known variables: time 1.11e-07/2.342, allocations: 0 / 0.7519 GB, free: 191.9 MB / 0.5919 GB Notification: Performance of remove unused functions: time 0.002739/2.344, allocations: 1.239 MB / 0.7531 GB, free: 191.9 MB / 0.5919 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 1 * 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 (13): * Single equations (assignments): 12 * 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): 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.005101/2.349, allocations: 2.56 MB / 0.7556 GB, free: 190.1 MB / 0.5919 GB Notification: Performance of simCode: created initialization part: time 0.0005778/2.35, allocations: 233.9 kB / 0.7559 GB, free: 190 MB / 0.5919 GB Notification: Performance of simCode: created event and clocks part: time 3.346e-06/2.35, allocations: 0 / 0.7559 GB, free: 190 MB / 0.5919 GB Notification: Performance of simCode: created simulation system equations: time 0.0002267/2.35, allocations: 82.84 kB / 0.7559 GB, free: 189.9 MB / 0.5919 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0006973/2.351, allocations: 132 kB / 0.7561 GB, free: 189.8 MB / 0.5919 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003572/2.354, allocations: 3.086 MB / 0.7591 GB, free: 187 MB / 0.5919 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0001575/2.355, allocations: 0.7675 MB / 0.7598 GB, free: 186.2 MB / 0.5919 GB Notification: Performance of simCode: alias equations: time 0.000104/2.355, allocations: 25.56 kB / 0.7598 GB, free: 186.2 MB / 0.5919 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000112/2.355, allocations: 91.59 kB / 0.7599 GB, free: 186.2 MB / 0.5919 GB Notification: Performance of SimCode: time 4.51e-07/2.355, allocations: 0 / 0.7599 GB, free: 186.2 MB / 0.5919 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.06754/2.422, allocations: 48.43 MB / 0.8072 GB, free: 138.6 MB / 0.5919 GB Notification: Performance of buildModelFMU: Generate platform static: time 14.15/16.57, allocations: 3.953 kB / 0.8072 GB, free: 138.6 MB / 0.5919 GB " [Timeout remaining time 643] (rm -f ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDiaphragm.pipe ; mkfifo ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDiaphragm.pipe ; head -c 1048576 < ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDiaphragm.pipe >> ../files/ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDiaphragm.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --tempDir=temp_ThermoSysPro_ThermoSysPro_Examples_SimpleExamples_TestDiaphragm_fmu --startTime=0 --stopTime=1000 --stepSize=0.4 --timeout=50 --tolerance=1e-06 ThermoSysPro_ThermoSysPro_Examples_SimpleExamples_TestDiaphragm.fmu > ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDiaphragm.pipe 2>&1) [Timeout 52.5] [Calling sys.exit(0), Time elapsed: 18.700935679022223] Failed to read output from testmodel.py, exit status != 0: 16.884504683024716 16.893879193 14.960199791 Calling exit ...