Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.PrescribedOutlet_Water.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001446/0.001446, allocations: 106.5 kB / 16.45 MB, free: 6.035 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001416/0.001416, allocations: 192.5 kB / 19.41 MB, free: 3.539 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.435/1.435, allocations: 225.6 MB / 247.8 MB, free: 13.93 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo): time 0.002552/0.002552, allocations: 284.5 kB / 303 MB, free: 9.473 MB / 238.1 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo): time 1.234/1.234, allocations: 180.9 MB / 0.5261 GB, free: 14.63 MB / 382.1 MB " [Timeout remaining time 179] Using package BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo) Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo) Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo) Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo) Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo) Running command: "" <> buildModelFMU(BuildingSystems.Fluid.Interfaces.Examples.PrescribedOutlet_Water,fileNamePrefix="BuildingSystems_BuildingSystems_Fluid_Interfaces_Examples_PrescribedOutlet_Water",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(BuildingSystems.Fluid.Interfaces.Examples.PrescribedOutlet_Water,fileNamePrefix="BuildingSystems_BuildingSystems_Fluid_Interfaces_Examples_PrescribedOutlet_Water",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 0.002722/0.002722, allocations: 103.4 kB / 0.7248 GB, free: 40.06 MB / 0.545 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1923/0.195, allocations: 94.16 MB / 0.8168 GB, free: 5.395 MB / 0.5606 GB Notification: Performance of NFInst.instantiate(BuildingSystems.Fluid.Interfaces.Examples.PrescribedOutlet_Water): time 0.03492/0.2299, allocations: 29.54 MB / 0.8456 GB, free: 7.746 MB / 0.5919 GB Notification: Performance of NFInst.instExpressions: time 0.01202/0.242, allocations: 6.887 MB / 0.8523 GB, free: 0.8398 MB / 0.5919 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001611/0.2436, allocations: 47.69 kB / 0.8524 GB, free: 0.793 MB / 0.5919 GB Notification: Performance of NFTyping.typeComponents: time 0.001824/0.2454, allocations: 0.707 MB / 0.8531 GB, free: 84 kB / 0.5919 GB Notification: Performance of NFTyping.typeBindings: time 0.004404/0.2498, allocations: 1.515 MB / 0.8545 GB, free: 14.56 MB / 0.6075 GB Notification: Performance of NFTyping.typeClassSections: time 0.003246/0.253, allocations: 1.165 MB / 0.8557 GB, free: 13.4 MB / 0.6075 GB Notification: Performance of NFFlatten.flatten: time 0.003927/0.257, allocations: 2.481 MB / 0.8581 GB, free: 10.91 MB / 0.6075 GB Notification: Performance of NFFlatten.resolveConnections: time 0.001226/0.2582, allocations: 0.6812 MB / 0.8588 GB, free: 10.21 MB / 0.6075 GB Notification: Performance of NFEvalConstants.evaluate: time 0.00204/0.2602, allocations: 1.047 MB / 0.8598 GB, free: 9.164 MB / 0.6075 GB Notification: Performance of NFSimplifyModel.simplify: time 0.001167/0.2614, allocations: 0.8714 MB / 0.8606 GB, free: 8.289 MB / 0.6075 GB Notification: Performance of NFPackage.collectConstants: time 0.0001292/0.2615, allocations: 68 kB / 0.8607 GB, free: 8.223 MB / 0.6075 GB Notification: Performance of NFFlatten.collectFunctions: time 0.002016/0.2636, allocations: 0.8499 MB / 0.8615 GB, free: 7.371 MB / 0.6075 GB Notification: Performance of NFScalarize.scalarize: time 0.0003365/0.2639, allocations: 286.8 kB / 0.8618 GB, free: 7.09 MB / 0.6075 GB Notification: Performance of NFVerifyModel.verify: time 0.0006094/0.2645, allocations: 0.5514 MB / 0.8623 GB, free: 6.535 MB / 0.6075 GB Notification: Performance of NFConvertDAE.convert: time 0.002423/0.2669, allocations: 1.63 MB / 0.8639 GB, free: 4.898 MB / 0.6075 GB Notification: Performance of FrontEnd - DAE generated: time 4.128e-06/0.2669, allocations: 0 / 0.8639 GB, free: 4.898 MB / 0.6075 GB Notification: Performance of FrontEnd: time 1.813e-06/0.2669, allocations: 0 / 0.8639 GB, free: 4.898 MB / 0.6075 GB Notification: Performance of Transformations before backend: time 1.69e-05/0.2669, allocations: 0 / 0.8639 GB, free: 4.898 MB / 0.6075 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 176 * Number of variables: 176 Notification: Performance of Generate backend data structure: time 0.002767/0.2697, allocations: 1.611 MB / 0.8655 GB, free: 3.23 MB / 0.6075 GB Notification: Performance of prepare preOptimizeDAE: time 4.516e-05/0.2698, allocations: 12.03 kB / 0.8655 GB, free: 3.219 MB / 0.6075 GB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001529/0.2699, allocations: 118.7 kB / 0.8656 GB, free: 3.094 MB / 0.6075 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003367/0.2733, allocations: 0.5853 MB / 0.8662 GB, free: 2.508 MB / 0.6075 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.001636/0.2749, allocations: 0.8846 MB / 0.8671 GB, free: 1.57 MB / 0.6075 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.431e-05/0.275, allocations: 66.05 kB / 0.8671 GB, free: 1.504 MB / 0.6075 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001323/0.2751, allocations: 72 kB / 0.8672 GB, free: 1.434 MB / 0.6075 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.002415/0.2775, allocations: 1.099 MB / 0.8683 GB, free: 260 kB / 0.6075 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.403e-05/0.2775, allocations: 7.938 kB / 0.8683 GB, free: 252 kB / 0.6075 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.536e-05/0.2776, allocations: 32 kB / 0.8683 GB, free: 220 kB / 0.6075 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.687e-05/0.2777, allocations: 16 kB / 0.8683 GB, free: 204 kB / 0.6075 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002992/0.2806, allocations: 1.004 MB / 0.8693 GB, free: 15.2 MB / 0.6231 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.006227/0.2869, allocations: 4.944 MB / 0.8741 GB, free: 9.965 MB / 0.6231 GB Notification: Performance of preOpt comSubExp (simulation): time 0.002796/0.2897, allocations: 0.8677 MB / 0.875 GB, free: 9.086 MB / 0.6231 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.001388/0.2911, allocations: 467.1 kB / 0.8754 GB, free: 8.629 MB / 0.6231 GB Notification: Performance of preOpt evalFunc (simulation): time 0.001494/0.2925, allocations: 1.595 MB / 0.877 GB, free: 6.684 MB / 0.6231 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0016/0.2941, allocations: 0.565 MB / 0.8775 GB, free: 6.102 MB / 0.6231 GB Notification: Performance of pre-optimization done (n=61): time 2.936e-06/0.2942, allocations: 0 / 0.8775 GB, free: 6.102 MB / 0.6231 GB Notification: Performance of matching and sorting (n=61): time 0.004595/0.2987, allocations: 1.489 MB / 0.879 GB, free: 4.609 MB / 0.6231 GB Notification: Performance of inlineWhenForInitialization (initialization): time 5.513e-05/0.2988, allocations: 59.97 kB / 0.8791 GB, free: 4.539 MB / 0.6231 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00143/0.3002, allocations: 1.112 MB / 0.8801 GB, free: 3.414 MB / 0.6231 GB Notification: Performance of collectPreVariables (initialization): time 9.84e-05/0.3003, allocations: 49.7 kB / 0.8802 GB, free: 3.359 MB / 0.6231 GB Notification: Performance of collectInitialEqns (initialization): time 0.0004973/0.3008, allocations: 0.552 MB / 0.8807 GB, free: 2.801 MB / 0.6231 GB Notification: Performance of collectInitialBindings (initialization): time 0.0002171/0.301, allocations: 222.2 kB / 0.8809 GB, free: 2.582 MB / 0.6231 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002613/0.3013, allocations: 162.6 kB / 0.8811 GB, free: 2.418 MB / 0.6231 GB Notification: Performance of setup shared object (initialization): time 0.0001552/0.3015, allocations: 334 kB / 0.8814 GB, free: 2.086 MB / 0.6231 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001408/0.3029, allocations: 453.6 kB / 0.8818 GB, free: 1.645 MB / 0.6231 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.00166/0.3045, allocations: 0.7166 MB / 0.8825 GB, free: 0.8125 MB / 0.6231 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.002949/0.3075, allocations: 1.124 MB / 0.8836 GB, free: 15.58 MB / 0.6387 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.685e-06/0.3075, allocations: 4 kB / 0.8836 GB, free: 15.58 MB / 0.6387 GB Notification: Performance of matching and sorting (n=100) (initialization): time 0.003524/0.311, allocations: 1.275 MB / 0.8849 GB, free: 14.29 MB / 0.6387 GB Notification: Performance of prepare postOptimizeDAE: time 2.502e-05/0.311, allocations: 12 kB / 0.8849 GB, free: 14.28 MB / 0.6387 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.297e-05/0.311, allocations: 4 kB / 0.8849 GB, free: 14.28 MB / 0.6387 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.521e-05/0.3111, allocations: 12 kB / 0.8849 GB, free: 14.27 MB / 0.6387 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001202/0.3123, allocations: 276.3 kB / 0.8852 GB, free: 14 MB / 0.6387 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.087e-05/0.3123, allocations: 15.94 kB / 0.8852 GB, free: 13.98 MB / 0.6387 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001145/0.3134, allocations: 175.3 kB / 0.8854 GB, free: 13.81 MB / 0.6387 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.333e-05/0.3135, allocations: 47.98 kB / 0.8854 GB, free: 13.76 MB / 0.6387 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 34 * Number of states: 0 () * Number of discrete variables: 15 ($PRE.setHeaHigPow.nextTimeEvent,$whenCondition3,$PRE.setCooLimPow.nextTimeEvent,$whenCondition2,$PRE.setHeaCooUnl.nextTimeEvent,$whenCondition1,setHeaCooUnl.nextTimeEventScaled,$PRE.setHeaCooUnl.nextTimeEventScaled,setHeaCooUnl.nextTimeEvent,setCooLimPow.nextTimeEventScaled,$PRE.setCooLimPow.nextTimeEventScaled,setCooLimPow.nextTimeEvent,setHeaHigPow.nextTimeEventScaled,$PRE.setHeaHigPow.nextTimeEventScaled,setHeaHigPow.nextTimeEvent) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (100): * Single equations (assignments): 100 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * 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.0005019/0.314, allocations: 296.2 kB / 0.8857 GB, free: 13.46 MB / 0.6387 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002054/0.3142, allocations: 131.1 kB / 0.8858 GB, free: 13.34 MB / 0.6387 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003768/0.318, allocations: 1.363 MB / 0.8871 GB, free: 11.96 MB / 0.6387 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.09e-05/0.318, allocations: 15.92 kB / 0.8872 GB, free: 11.95 MB / 0.6387 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 7.384e-06/0.318, allocations: 0 / 0.8872 GB, free: 11.95 MB / 0.6387 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.119e-05/0.3181, allocations: 3.984 kB / 0.8872 GB, free: 11.95 MB / 0.6387 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00516/0.3232, allocations: 2.374 MB / 0.8895 GB, free: 9.496 MB / 0.6387 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.955e-06/0.3232, allocations: 0 / 0.8895 GB, free: 9.496 MB / 0.6387 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001032/0.3242, allocations: 195.9 kB / 0.8897 GB, free: 9.305 MB / 0.6387 GB Notification: Performance of postOpt tearingSystem (simulation): time 1.204e-05/0.3243, allocations: 4 kB / 0.8897 GB, free: 9.301 MB / 0.6387 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.435e-05/0.3243, allocations: 27.97 kB / 0.8897 GB, free: 9.273 MB / 0.6387 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 8.225e-06/0.3243, allocations: 4 kB / 0.8897 GB, free: 9.27 MB / 0.6387 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.871e-06/0.3243, allocations: 7.938 kB / 0.8897 GB, free: 9.262 MB / 0.6387 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005072/0.3294, allocations: 1.97 MB / 0.8916 GB, free: 7.254 MB / 0.6387 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0005381/0.33, allocations: 284 kB / 0.8919 GB, free: 6.957 MB / 0.6387 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001478/0.3301, allocations: 16 kB / 0.8919 GB, free: 6.941 MB / 0.6387 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009074/0.331, allocations: 111.8 kB / 0.892 GB, free: 6.832 MB / 0.6387 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001055/0.3311, allocations: 52.44 kB / 0.8921 GB, free: 6.781 MB / 0.6387 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.461e-05/0.3312, allocations: 31.97 kB / 0.8921 GB, free: 6.75 MB / 0.6387 GB Notification: Performance of sorting global known variables: time 0.0009678/0.3322, allocations: 0.7716 MB / 0.8929 GB, free: 5.973 MB / 0.6387 GB Notification: Performance of sort global known variables: time 9e-08/0.3322, allocations: 0 / 0.8929 GB, free: 5.973 MB / 0.6387 GB Notification: Performance of remove unused functions: time 0.001165/0.3333, allocations: 347.3 kB / 0.8932 GB, free: 5.633 MB / 0.6387 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 7 * Number of states: 3 (heaHigPow.T,cooLimPow.T,heaCooUnl.T) * Number of discrete variables: 9 ($whenCondition3,$whenCondition2,$whenCondition1,setHeaHigPow.nextTimeEvent,setHeaHigPow.nextTimeEventScaled,setCooLimPow.nextTimeEvent,setCooLimPow.nextTimeEventScaled,setHeaCooUnl.nextTimeEvent,setHeaCooUnl.nextTimeEventScaled) * Number of discrete states: 6 (setHeaHigPow.nextTimeEvent,setCooLimPow.nextTimeEvent,setHeaCooUnl.nextTimeEvent,setHeaCooUnl.nextTimeEventScaled,setCooLimPow.nextTimeEventScaled,setHeaHigPow.nextTimeEventScaled) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (70): * Single equations (assignments): 55 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 9 * When equations: 6 * 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.00726/0.3406, allocations: 3.085 MB / 0.8962 GB, free: 2.684 MB / 0.6387 GB Notification: Performance of simCode: created initialization part: time 0.003249/0.3438, allocations: 1.083 MB / 0.8973 GB, free: 1.602 MB / 0.6387 GB Notification: Performance of simCode: created event and clocks part: time 4.659e-06/0.3438, allocations: 0 / 0.8973 GB, free: 1.602 MB / 0.6387 GB Notification: Performance of simCode: created simulation system equations: time 0.001582/0.3454, allocations: 0.5384 MB / 0.8978 GB, free: 1.066 MB / 0.6387 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002012/0.3474, allocations: 459.8 kB / 0.8982 GB, free: 0.6289 MB / 0.6387 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01886/0.3663, allocations: 9.631 MB / 0.9076 GB, free: 6.621 MB / 0.6544 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007442/0.367, allocations: 1.104 MB / 0.9087 GB, free: 5.488 MB / 0.6544 GB Notification: Performance of simCode: alias equations: time 0.0009214/0.3679, allocations: 251.8 kB / 0.909 GB, free: 5.242 MB / 0.6544 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006399/0.3686, allocations: 467.2 kB / 0.9094 GB, free: 4.785 MB / 0.6544 GB Notification: Performance of SimCode: time 8.82e-07/0.3686, allocations: 0 / 0.9094 GB, free: 4.785 MB / 0.6544 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.07186/0.4404, allocations: 30.85 MB / 0.9395 GB, free: 6.348 MB / 0.6856 GB Notification: Performance of buildModelFMU: Generate platform static: time 10.11/10.55, allocations: 17.31 kB / 0.9395 GB, free: 6.34 MB / 0.6856 GB " [Timeout remaining time 649] (rm -f BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.PrescribedOutlet_Water.pipe ; mkfifo BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.PrescribedOutlet_Water.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.PrescribedOutlet_Water.pipe >> ../files/BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.PrescribedOutlet_Water.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --tempDir=temp_BuildingSystems_BuildingSystems_Fluid_Interfaces_Examples_PrescribedOutlet_Water_fmu --startTime=0 --stopTime=1200 --stepSize=0.48 --timeout=50 --tolerance=1e-06 BuildingSystems_BuildingSystems_Fluid_Interfaces_Examples_PrescribedOutlet_Water.fmu > BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.PrescribedOutlet_Water.pipe 2>&1) [Timeout 52.5] [Calling sys.exit(0), Time elapsed: 14.99031696189195] Failed to read output from testmodel.py, exit status != 0: 10.697358424309641 10.720750777 10.449842904 Calling exit ...