Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.Movers.Validation.Pump_y_stratos.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.00147/0.00147, allocations: 114 kB / 17.12 MB, free: 6.008 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.001695/0.001695, allocations: 211.2 kB / 20.09 MB, free: 3.055 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.457/1.457, allocations: 230.6 MB / 253.5 MB, free: 15.09 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo): time 0.9766/0.9766, allocations: 150 MB / 459.5 MB, free: 5.312 MB / 350.1 MB " [Timeout remaining time 179] Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo) Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: "" <> buildModelFMU(IBPSA.Fluid.Movers.Validation.Pump_y_stratos,fileNamePrefix="IBPSA_latest_IBPSA_Fluid_Movers_Validation_Pump_y_stratos",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(IBPSA.Fluid.Movers.Validation.Pump_y_stratos,fileNamePrefix="IBPSA_latest_IBPSA_Fluid_Movers_Validation_Pump_y_stratos",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660] "Notification: IBPSA 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.002086/0.002086, allocations: 68.95 kB / 0.6361 GB, free: 30.53 MB / 0.4981 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1703/0.1724, allocations: 89.12 MB / 0.7232 GB, free: 4.062 MB / 0.5294 GB Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Movers.Validation.Pump_y_stratos): time 0.6737/0.8462, allocations: 214.7 MB / 0.9328 GB, free: 1.461 MB / 0.67 GB Notification: Performance of NFInst.instExpressions: time 0.1012/0.9474, allocations: 70.32 MB / 1.001 GB, free: 2.352 MB / 0.7012 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.02018/0.9676, allocations: 492.2 kB / 1.002 GB, free: 1.867 MB / 0.7012 GB Notification: Performance of NFTyping.typeComponents: time 0.01928/0.9869, allocations: 5.486 MB / 1.007 GB, free: 12.36 MB / 0.7169 GB Notification: Performance of NFTyping.typeBindings: time 0.03549/1.022, allocations: 11.74 MB / 1.019 GB, free: 0.5703 MB / 0.7169 GB Notification: Performance of NFTyping.typeClassSections: time 0.02352/1.046, allocations: 9.155 MB / 1.028 GB, free: 7.477 MB / 0.7325 GB Notification: Performance of NFFlatten.flatten: time 0.07498/1.121, allocations: 49.17 MB / 1.076 GB, free: 6.219 MB / 0.7794 GB Notification: Performance of NFFlatten.resolveConnections: time 0.01681/1.138, allocations: 6.979 MB / 1.083 GB, free: 15.12 MB / 0.795 GB Notification: Performance of NFEvalConstants.evaluate: time 0.02634/1.164, allocations: 10.01 MB / 1.092 GB, free: 5.109 MB / 0.795 GB Notification: Performance of NFSimplifyModel.simplify: time 0.01528/1.179, allocations: 7.764 MB / 1.1 GB, free: 13.31 MB / 0.8106 GB Notification: Performance of NFPackage.collectConstants: time 0.005321/1.185, allocations: 1.074 MB / 1.101 GB, free: 12.23 MB / 0.8106 GB Notification: Performance of NFFlatten.collectFunctions: time 0.01523/1.2, allocations: 4.198 MB / 1.105 GB, free: 8.031 MB / 0.8106 GB Notification: Performance of NFScalarize.scalarize: time 0.008622/1.208, allocations: 5.428 MB / 1.11 GB, free: 2.586 MB / 0.8106 GB Notification: Performance of NFVerifyModel.verify: time 0.01697/1.225, allocations: 7.918 MB / 1.118 GB, free: 10.63 MB / 0.8262 GB Notification: Performance of NFConvertDAE.convert: time 0.0418/1.267, allocations: 22.41 MB / 1.14 GB, free: 4.133 MB / 0.8419 GB Notification: Performance of FrontEnd - DAE generated: time 7.384e-06/1.267, allocations: 0 / 1.14 GB, free: 4.133 MB / 0.8419 GB Notification: Performance of FrontEnd: time 2.134e-06/1.267, allocations: 0 / 1.14 GB, free: 4.133 MB / 0.8419 GB Notification: Performance of Transformations before backend: time 0.0008746/1.268, allocations: 4 kB / 1.14 GB, free: 4.129 MB / 0.8419 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1224 * Number of variables: 1224 Notification: Performance of Generate backend data structure: time 0.046/1.314, allocations: 16.59 MB / 1.156 GB, free: 3.312 MB / 0.8575 GB Notification: Performance of prepare preOptimizeDAE: time 5.363e-05/1.314, allocations: 8.031 kB / 1.156 GB, free: 3.305 MB / 0.8575 GB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.002156/1.316, allocations: 0.6264 MB / 1.157 GB, free: 2.668 MB / 0.8575 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02845/1.345, allocations: 4.84 MB / 1.162 GB, free: 13.81 MB / 0.8731 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.05354/1.398, allocations: 25.3 MB / 1.186 GB, free: 4.402 MB / 0.8887 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000639/1.399, allocations: 421.6 kB / 1.187 GB, free: 3.988 MB / 0.8887 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.002688/1.402, allocations: 0.5468 MB / 1.187 GB, free: 3.441 MB / 0.8887 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.02248/1.424, allocations: 7.693 MB / 1.195 GB, free: 11.5 MB / 0.9044 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.00017/1.424, allocations: 15.86 kB / 1.195 GB, free: 11.48 MB / 0.9044 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001424/1.426, allocations: 204 kB / 1.195 GB, free: 11.28 MB / 0.9044 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001239/1.426, allocations: 116 kB / 1.195 GB, free: 11.17 MB / 0.9044 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02054/1.446, allocations: 6.136 MB / 1.201 GB, free: 5.016 MB / 0.9044 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.4647/1.911, allocations: 34.98 MB / 1.235 GB, free: 344.4 MB / 0.92 GB Notification: Performance of preOpt comSubExp (simulation): time 0.01626/1.927, allocations: 4.752 MB / 1.24 GB, free: 343 MB / 0.92 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.006747/1.934, allocations: 2.358 MB / 1.242 GB, free: 342.3 MB / 0.92 GB Notification: Performance of preOpt evalFunc (simulation): time 0.02009/1.954, allocations: 11.71 MB / 1.254 GB, free: 335.2 MB / 0.92 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.974e-05/1.954, allocations: 68.03 kB / 1.254 GB, free: 335.2 MB / 0.92 GB Notification: Performance of pre-optimization done (n=237): time 4.709e-06/1.954, allocations: 0 / 1.254 GB, free: 335.2 MB / 0.92 GB Notification: Performance of matching and sorting (n=237): time 0.02367/1.978, allocations: 8.02 MB / 1.261 GB, free: 333.4 MB / 0.92 GB Notification: Performance of inlineWhenForInitialization (initialization): time 5.42e-05/1.978, allocations: 77.12 kB / 1.262 GB, free: 333.3 MB / 0.92 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03123/2.009, allocations: 20.24 MB / 1.281 GB, free: 324.1 MB / 0.92 GB Notification: Performance of collectPreVariables (initialization): time 0.001202/2.01, allocations: 106.3 kB / 1.281 GB, free: 324 MB / 0.92 GB Notification: Performance of collectInitialEqns (initialization): time 0.005518/2.016, allocations: 6.299 MB / 1.288 GB, free: 318.9 MB / 0.92 GB Notification: Performance of collectInitialBindings (initialization): time 0.001471/2.017, allocations: 0.9212 MB / 1.288 GB, free: 318.2 MB / 0.92 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.00486/2.022, allocations: 2.171 MB / 1.291 GB, free: 317 MB / 0.92 GB Notification: Performance of setup shared object (initialization): time 7.625e-05/2.022, allocations: 308.7 kB / 1.291 GB, free: 316.7 MB / 0.92 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.01029/2.033, allocations: 6.074 MB / 1.297 GB, free: 313.8 MB / 0.92 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.01285/2.045, allocations: 8.615 MB / 1.305 GB, free: 304.9 MB / 0.92 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.02068/2.066, allocations: 13.48 MB / 1.318 GB, free: 290.8 MB / 0.92 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.992e-05/2.066, allocations: 20 kB / 1.318 GB, free: 290.8 MB / 0.92 GB Notification: Performance of matching and sorting (n=1247) (initialization): time 0.03037/2.097, allocations: 16 MB / 1.334 GB, free: 274.8 MB / 0.92 GB Notification: Performance of prepare postOptimizeDAE: time 8.498e-05/2.097, allocations: 35.84 kB / 1.334 GB, free: 274.8 MB / 0.92 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.829e-05/2.097, allocations: 60 kB / 1.334 GB, free: 274.8 MB / 0.92 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0001162/2.097, allocations: 103.9 kB / 1.334 GB, free: 274.7 MB / 0.92 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007822/2.105, allocations: 1.882 MB / 1.336 GB, free: 272.8 MB / 0.92 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001726/2.105, allocations: 135.6 kB / 1.336 GB, free: 272.7 MB / 0.92 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01352/2.118, allocations: 1.271 MB / 1.337 GB, free: 271.4 MB / 0.92 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001844/2.12, allocations: 451.8 kB / 1.338 GB, free: 271 MB / 0.92 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01815/2.138, allocations: 8.437 MB / 1.346 GB, free: 262.6 MB / 0.92 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01226/2.151, allocations: 8.033 MB / 1.354 GB, free: 253.7 MB / 0.92 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01871/2.169, allocations: 12.33 MB / 1.366 GB, free: 240.5 MB / 0.92 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.267e-05/2.169, allocations: 23.94 kB / 1.366 GB, free: 240.5 MB / 0.92 GB Notification: Performance of matching and sorting (n=1247) (initialization_lambda0): time 0.02764/2.197, allocations: 14.82 MB / 1.38 GB, free: 225.6 MB / 0.92 GB Notification: Performance of prepare postOptimizeDAE: time 6.824e-05/2.197, allocations: 33 kB / 1.38 GB, free: 225.6 MB / 0.92 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.348e-05/2.197, allocations: 60 kB / 1.381 GB, free: 225.6 MB / 0.92 GB Notification: Performance of postOpt tearingSystem (initialization): time 8.717e-05/2.197, allocations: 104 kB / 1.381 GB, free: 225.5 MB / 0.92 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007165/2.204, allocations: 1.818 MB / 1.382 GB, free: 223.6 MB / 0.92 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001688/2.205, allocations: 139.5 kB / 1.383 GB, free: 223.5 MB / 0.92 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01222/2.217, allocations: 1.017 MB / 1.384 GB, free: 222.5 MB / 0.92 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00153/2.218, allocations: 411.9 kB / 1.384 GB, free: 222.1 MB / 0.92 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 281 * 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 (872): * Single equations (assignments): 852 * Array equations: 10 * Algorithm blocks: 0 * Record equations: 10 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of prepare postOptimizeDAE: time 0.002605/2.221, allocations: 0.576 MB / 1.384 GB, free: 221.5 MB / 0.92 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004604/2.226, allocations: 1.327 MB / 1.386 GB, free: 220.2 MB / 0.92 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02082/2.246, allocations: 7.032 MB / 1.393 GB, free: 213.1 MB / 0.92 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.648e-05/2.246, allocations: 39.98 kB / 1.393 GB, free: 213.1 MB / 0.92 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.533e-05/2.246, allocations: 0 / 1.393 GB, free: 213.1 MB / 0.92 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.706e-05/2.246, allocations: 23.88 kB / 1.393 GB, free: 213.1 MB / 0.92 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.04146/2.288, allocations: 15.07 MB / 1.407 GB, free: 198 MB / 0.92 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.647e-05/2.288, allocations: 4 kB / 1.407 GB, free: 197.9 MB / 0.92 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00465/2.293, allocations: 0.8739 MB / 1.408 GB, free: 197.1 MB / 0.92 GB Notification: Performance of postOpt tearingSystem (simulation): time 4.335e-05/2.293, allocations: 8 kB / 1.408 GB, free: 197.1 MB / 0.92 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0005872/2.293, allocations: 119.8 kB / 1.408 GB, free: 196.9 MB / 0.92 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.59e-05/2.293, allocations: 11.94 kB / 1.408 GB, free: 196.9 MB / 0.92 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.946e-06/2.293, allocations: 4 kB / 1.408 GB, free: 196.9 MB / 0.92 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02476/2.318, allocations: 9.652 MB / 1.418 GB, free: 187.2 MB / 0.92 GB Notification: Performance of postOpt removeConstants (simulation): time 0.007334/2.325, allocations: 2.283 MB / 1.42 GB, free: 184.9 MB / 0.92 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004278/2.33, allocations: 59.94 kB / 1.42 GB, free: 184.8 MB / 0.92 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009281/2.339, allocations: 487.6 kB / 1.421 GB, free: 184.3 MB / 0.92 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003853/2.339, allocations: 182 kB / 1.421 GB, free: 184.2 MB / 0.92 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0006202/2.34, allocations: 167.8 kB / 1.421 GB, free: 184 MB / 0.92 GB Notification: Performance of sorting global known variables: time 0.02397/2.364, allocations: 14.11 MB / 1.435 GB, free: 170 MB / 0.92 GB Notification: Performance of sort global known variables: time 1.8e-07/2.364, allocations: 0 / 1.435 GB, free: 170 MB / 0.92 GB Notification: Performance of remove unused functions: time 0.02169/2.386, allocations: 5.265 MB / 1.44 GB, free: 164.7 MB / 0.92 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 5 * Number of states: 10 (pump1.motSpe.y,pump2.motSpe.y,pump3.motSpe.y,pump4.motSpe.y,pump5.motSpe.y,forcedPump1.motSpe.y,forcedPump2.motSpe.y,forcedPump3.motSpe.y,forcedPump4.motSpe.y,forcedPump5.motSpe.y) * 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 (294): * Single equations (assignments): 272 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 22 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of Backend phase and start with SimCode phase: time 0.0288/2.414, allocations: 11.22 MB / 1.451 GB, free: 153.5 MB / 0.92 GB Notification: Performance of simCode: created initialization part: time 0.02845/2.443, allocations: 15.89 MB / 1.466 GB, free: 137.6 MB / 0.92 GB Notification: Performance of simCode: created event and clocks part: time 8.727e-06/2.443, allocations: 0 / 1.466 GB, free: 137.6 MB / 0.92 GB Notification: Performance of simCode: created simulation system equations: time 0.006892/2.45, allocations: 2.578 MB / 1.469 GB, free: 135 MB / 0.92 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.03105/2.481, allocations: 7.004 MB / 1.476 GB, free: 128.2 MB / 0.92 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2234/2.704, allocations: 124.3 MB / 1.597 GB, free: 1.52 MB / 0.92 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.7748/3.479, allocations: 6.621 MB / 1.604 GB, free: 333.7 MB / 0.92 GB Notification: Performance of simCode: alias equations: time 0.01681/3.496, allocations: 3.726 MB / 1.607 GB, free: 333.3 MB / 0.92 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01233/3.508, allocations: 6.446 MB / 1.613 GB, free: 331.5 MB / 0.92 GB Notification: Performance of SimCode: time 1.162e-06/3.508, allocations: 0 / 1.613 GB, free: 331.5 MB / 0.92 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.8434/4.352, allocations: 356.6 MB / 1.962 GB, free: 312.9 MB / 0.92 GB Notification: Performance of buildModelFMU: Generate platform static: time 55.35/59.71, allocations: 12.14 kB / 1.962 GB, free: 312.9 MB / 0.92 GB " [Timeout remaining time 600] (rm -f IBPSA_latest_IBPSA.Fluid.Movers.Validation.Pump_y_stratos.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Movers.Validation.Pump_y_stratos.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Movers.Validation.Pump_y_stratos.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Movers.Validation.Pump_y_stratos.sim & python3 -m fmpy simulate --output-file IBPSA_latest_IBPSA.Fluid.Movers.Validation.Pump_y_stratos_res.csv --start-time 0 --stop-time 1000 --timeout 50 --relative-tolerance 1e-08 --interface-type ModelExchange --solver CVode --output-interval 0.4 IBPSA_latest_IBPSA_Fluid_Movers_Validation_Pump_y_stratos.fmu > IBPSA_latest_IBPSA.Fluid.Movers.Validation.Pump_y_stratos.pipe 2>&1) [Timeout 52.5] [Calling sys.exit(0), Time elapsed: 64.0315283399541] Failed to read output from testmodel.py, exit status != 0: 60.01079358998686 60.031987702 58.760248673 Calling exit ...