Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.Examples.Performance.Example4.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.00126/0.00126, allocations: 120.9 kB / 17.16 MB, free: 5.914 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.001308/0.001308, allocations: 208 kB / 20.13 MB, free: 2.969 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.437/1.437, allocations: 230.6 MB / 253.5 MB, free: 15.1 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.808/2.808, allocations: 0.49 GB / 0.7923 GB, free: 1.449 MB / 0.6231 GB " [Timeout remaining time 177] Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/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(Buildings.Fluid.Examples.Performance.Example4,fileNamePrefix="Buildings_12_Buildings_Fluid_Examples_Performance_Example4",fmuType="cs",version="2.0",platforms={"static"}) "" <> buildModelFMU(Buildings.Fluid.Examples.Performance.Example4,fileNamePrefix="Buildings_12_Buildings_Fluid_Examples_Performance_Example4",fmuType="cs",version="2.0",platforms={"static"}) [Timeout 300] "Notification: Buildings 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.001897/0.001897, allocations: 67.89 kB / 1.15 GB, free: 15.43 MB / 0.9356 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.8454/0.8473, allocations: 176.1 MB / 1.321 GB, free: 24.77 MB / 1.061 GB Notification: Performance of NFInst.instantiate(Buildings.Fluid.Examples.Performance.Example4): time 0.2657/1.113, allocations: 241.6 MB / 1.557 GB, free: 7.539 MB / 1.232 GB Notification: Performance of NFInst.instExpressions: time 0.02412/1.137, allocations: 15.84 MB / 1.573 GB, free: 7.66 MB / 1.248 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.002719/1.14, allocations: 87.25 kB / 1.573 GB, free: 7.574 MB / 1.248 GB Notification: Performance of NFTyping.typeComponents: time 0.002985/1.143, allocations: 1.091 MB / 1.574 GB, free: 6.477 MB / 1.248 GB Notification: Performance of NFTyping.typeBindings: time 0.008441/1.151, allocations: 3.092 MB / 1.577 GB, free: 3.371 MB / 1.248 GB Notification: Performance of NFTyping.typeClassSections: time 0.004572/1.156, allocations: 1.687 MB / 1.579 GB, free: 1.691 MB / 1.248 GB Notification: Performance of NFFlatten.flatten: time 0.00525/1.161, allocations: 3.427 MB / 1.582 GB, free: 14.25 MB / 1.264 GB Notification: Performance of NFFlatten.resolveConnections: time 0.001646/1.163, allocations: 1.076 MB / 1.583 GB, free: 13.14 MB / 1.264 GB Notification: Performance of NFEvalConstants.evaluate: time 0.006869/1.17, allocations: 2.842 MB / 1.586 GB, free: 10.3 MB / 1.264 GB Notification: Performance of NFSimplifyModel.simplify: time 0.002555/1.172, allocations: 1.129 MB / 1.587 GB, free: 9.184 MB / 1.264 GB Notification: Performance of NFPackage.collectConstants: time 0.0002658/1.172, allocations: 119.9 kB / 1.587 GB, free: 9.066 MB / 1.264 GB Notification: Performance of NFFlatten.collectFunctions: time 0.006116/1.179, allocations: 3.235 MB / 1.59 GB, free: 5.824 MB / 1.264 GB Notification: Performance of NFScalarize.scalarize: time 0.000592/1.179, allocations: 486.2 kB / 1.591 GB, free: 5.348 MB / 1.264 GB Notification: Performance of NFVerifyModel.verify: time 0.001132/1.18, allocations: 0.8162 MB / 1.591 GB, free: 4.527 MB / 1.264 GB Notification: Performance of NFConvertDAE.convert: time 0.00537/1.186, allocations: 2.994 MB / 1.594 GB, free: 1.523 MB / 1.264 GB Notification: Performance of FrontEnd - DAE generated: time 5.431e-06/1.186, allocations: 0 / 1.594 GB, free: 1.523 MB / 1.264 GB Notification: Performance of FrontEnd: time 1.462e-06/1.186, allocations: 0 / 1.594 GB, free: 1.523 MB / 1.264 GB Notification: Performance of Transformations before backend: time 2.52e-05/1.186, allocations: 0 / 1.594 GB, free: 1.523 MB / 1.264 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 251 * Number of variables: 251 Notification: Performance of Generate backend data structure: time 0.003814/1.19, allocations: 2.072 MB / 1.596 GB, free: 15.39 MB / 1.279 GB Notification: Performance of prepare preOptimizeDAE: time 4.633e-05/1.19, allocations: 15.98 kB / 1.596 GB, free: 15.38 MB / 1.279 GB Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 3.982e-05/1.19, allocations: 22 kB / 1.596 GB, free: 15.36 MB / 1.279 GB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001782/1.19, allocations: 152.2 kB / 1.597 GB, free: 15.2 MB / 1.279 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00284/1.193, allocations: 0.5141 MB / 1.597 GB, free: 14.68 MB / 1.279 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.002341/1.195, allocations: 1.193 MB / 1.598 GB, free: 13.43 MB / 1.279 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.287e-05/1.195, allocations: 78 kB / 1.598 GB, free: 13.36 MB / 1.279 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001417/1.195, allocations: 100 kB / 1.598 GB, free: 13.26 MB / 1.279 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.002417/1.198, allocations: 1.35 MB / 1.6 GB, free: 11.79 MB / 1.279 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.737e-05/1.198, allocations: 11.92 kB / 1.6 GB, free: 11.78 MB / 1.279 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001041/1.198, allocations: 44 kB / 1.6 GB, free: 11.73 MB / 1.279 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.169e-05/1.198, allocations: 45.98 kB / 1.6 GB, free: 11.69 MB / 1.279 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002428/1.2, allocations: 1.054 MB / 1.601 GB, free: 10.64 MB / 1.279 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.008495/1.209, allocations: 7.472 MB / 1.608 GB, free: 2.668 MB / 1.279 GB Notification: Performance of preOpt comSubExp (simulation): time 0.001642/1.21, allocations: 0.5229 MB / 1.609 GB, free: 2.137 MB / 1.279 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0006264/1.211, allocations: 253.1 kB / 1.609 GB, free: 1.887 MB / 1.279 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0004117/1.211, allocations: 283.6 kB / 1.609 GB, free: 1.555 MB / 1.279 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.78e-05/1.211, allocations: 42.84 kB / 1.609 GB, free: 1.504 MB / 1.279 GB Notification: Performance of pre-optimization done (n=33): time 2.315e-06/1.211, allocations: 0 / 1.609 GB, free: 1.504 MB / 1.279 GB Notification: Performance of matching and sorting (n=33): time 0.002524/1.214, allocations: 0.8493 MB / 1.61 GB, free: 0.6484 MB / 1.279 GB Notification: Performance of inlineWhenForInitialization (initialization): time 4.823e-05/1.214, allocations: 51.41 kB / 1.61 GB, free: 0.5859 MB / 1.279 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002002/1.216, allocations: 1.396 MB / 1.611 GB, free: 15.18 MB / 1.295 GB Notification: Performance of collectPreVariables (initialization): time 7.423e-05/1.216, allocations: 37.7 kB / 1.612 GB, free: 15.14 MB / 1.295 GB Notification: Performance of collectInitialEqns (initialization): time 0.0006119/1.217, allocations: 0.7158 MB / 1.612 GB, free: 14.42 MB / 1.295 GB Notification: Performance of collectInitialBindings (initialization): time 0.0001363/1.217, allocations: 127 kB / 1.612 GB, free: 14.29 MB / 1.295 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002668/1.217, allocations: 170.5 kB / 1.613 GB, free: 14.12 MB / 1.295 GB Notification: Performance of setup shared object (initialization): time 0.0001582/1.217, allocations: 334 kB / 1.613 GB, free: 13.79 MB / 1.295 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008478/1.218, allocations: 312.6 kB / 1.613 GB, free: 13.48 MB / 1.295 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001173/1.219, allocations: 0.6969 MB / 1.614 GB, free: 12.61 MB / 1.295 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.001822/1.221, allocations: 0.915 MB / 1.615 GB, free: 11.54 MB / 1.295 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.695e-06/1.221, allocations: 4 kB / 1.615 GB, free: 11.53 MB / 1.295 GB Notification: Performance of matching and sorting (n=88) (initialization): time 0.002493/1.224, allocations: 1.066 MB / 1.616 GB, free: 10.46 MB / 1.295 GB Notification: Performance of prepare postOptimizeDAE: time 2.426e-05/1.224, allocations: 12 kB / 1.616 GB, free: 10.45 MB / 1.295 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.696e-05/1.224, allocations: 12 kB / 1.616 GB, free: 10.43 MB / 1.295 GB Notification: Performance of postOpt tearingSystem (initialization): time 3.016e-05/1.224, allocations: 16.78 kB / 1.616 GB, free: 10.42 MB / 1.295 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008323/1.225, allocations: 207.6 kB / 1.616 GB, free: 10.21 MB / 1.295 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.11e-05/1.225, allocations: 19.94 kB / 1.616 GB, free: 10.2 MB / 1.295 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001298/1.226, allocations: 191 kB / 1.616 GB, free: 10.01 MB / 1.295 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.361e-05/1.226, allocations: 39.98 kB / 1.616 GB, free: 9.969 MB / 1.295 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.00123/1.227, allocations: 0.5701 MB / 1.617 GB, free: 9.395 MB / 1.295 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001126/1.228, allocations: 0.6853 MB / 1.617 GB, free: 8.531 MB / 1.295 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001774/1.23, allocations: 0.9333 MB / 1.618 GB, free: 7.438 MB / 1.295 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.553e-06/1.23, allocations: 4 kB / 1.618 GB, free: 7.434 MB / 1.295 GB Notification: Performance of matching and sorting (n=88) (initialization_lambda0): time 0.002395/1.232, allocations: 1.047 MB / 1.619 GB, free: 6.379 MB / 1.295 GB Notification: Performance of prepare postOptimizeDAE: time 1.904e-05/1.232, allocations: 14.5 kB / 1.619 GB, free: 6.367 MB / 1.295 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.252e-05/1.233, allocations: 15.94 kB / 1.619 GB, free: 6.352 MB / 1.295 GB Notification: Performance of postOpt tearingSystem (initialization): time 1.698e-05/1.233, allocations: 16 kB / 1.619 GB, free: 6.336 MB / 1.295 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008118/1.233, allocations: 203.7 kB / 1.62 GB, free: 6.137 MB / 1.295 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.058e-05/1.233, allocations: 23.88 kB / 1.62 GB, free: 6.113 MB / 1.295 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001264/1.235, allocations: 135.6 kB / 1.62 GB, free: 5.98 MB / 1.295 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.055e-05/1.235, allocations: 39.98 kB / 1.62 GB, free: 5.941 MB / 1.295 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 52 * 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 (88): * Single equations (assignments): 88 * 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.0002704/1.235, allocations: 239.8 kB / 1.62 GB, free: 5.699 MB / 1.295 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002191/1.235, allocations: 151.1 kB / 1.62 GB, free: 5.551 MB / 1.295 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001736/1.237, allocations: 0.6412 MB / 1.621 GB, free: 4.895 MB / 1.295 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.101e-06/1.237, allocations: 4 kB / 1.621 GB, free: 4.891 MB / 1.295 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 5.089e-06/1.237, allocations: 0 / 1.621 GB, free: 4.891 MB / 1.295 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.508e-06/1.237, allocations: 0 / 1.621 GB, free: 4.891 MB / 1.295 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00357/1.24, allocations: 1.898 MB / 1.623 GB, free: 2.883 MB / 1.295 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.213e-05/1.241, allocations: 8 kB / 1.623 GB, free: 2.875 MB / 1.295 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000487/1.241, allocations: 96.08 kB / 1.623 GB, free: 2.781 MB / 1.295 GB Notification: Performance of postOpt tearingSystem (simulation): time 9.668e-06/1.241, allocations: 4 kB / 1.623 GB, free: 2.777 MB / 1.295 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.258e-05/1.241, allocations: 12 kB / 1.623 GB, free: 2.766 MB / 1.295 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.224e-05/1.241, allocations: 15.92 kB / 1.623 GB, free: 2.75 MB / 1.295 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.097e-06/1.241, allocations: 4 kB / 1.623 GB, free: 2.746 MB / 1.295 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001588/1.243, allocations: 0.8045 MB / 1.624 GB, free: 1.875 MB / 1.295 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0004679/1.243, allocations: 307.9 kB / 1.624 GB, free: 1.555 MB / 1.295 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001667/1.243, allocations: 8 kB / 1.624 GB, free: 1.547 MB / 1.295 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009757/1.244, allocations: 67.92 kB / 1.624 GB, free: 1.48 MB / 1.295 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 8.764e-05/1.244, allocations: 39.83 kB / 1.624 GB, free: 1.441 MB / 1.295 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.533e-05/1.244, allocations: 23.98 kB / 1.624 GB, free: 1.418 MB / 1.295 GB Notification: Performance of sorting global known variables: time 0.001514/1.246, allocations: 1.009 MB / 1.625 GB, free: 424 kB / 1.295 GB Notification: Performance of sort global known variables: time 9e-08/1.246, allocations: 0 / 1.625 GB, free: 424 kB / 1.295 GB Notification: Performance of remove unused functions: time 0.001818/1.248, allocations: 0.5852 MB / 1.626 GB, free: 15.82 MB / 1.311 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 16 * 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 (32): * Single equations (assignments): 32 * 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 Backend phase and start with SimCode phase: time 0.002296/1.25, allocations: 1.508 MB / 1.627 GB, free: 14.25 MB / 1.311 GB Notification: Performance of simCode: created initialization part: time 0.00291/1.253, allocations: 1.082 MB / 1.628 GB, free: 13.17 MB / 1.311 GB Notification: Performance of simCode: created event and clocks part: time 3.707e-06/1.253, allocations: 0 / 1.628 GB, free: 13.17 MB / 1.311 GB Notification: Performance of simCode: created simulation system equations: time 0.0006789/1.254, allocations: 253.4 kB / 1.628 GB, free: 12.92 MB / 1.311 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003333/1.257, allocations: 0.739 MB / 1.629 GB, free: 12.19 MB / 1.311 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01711/1.274, allocations: 9.872 MB / 1.639 GB, free: 1.781 MB / 1.311 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0008286/1.275, allocations: 1.19 MB / 1.64 GB, free: 0.5625 MB / 1.311 GB Notification: Performance of simCode: alias equations: time 0.001423/1.276, allocations: 391.8 kB / 1.64 GB, free: 180 kB / 1.311 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007016/1.277, allocations: 499.4 kB / 1.641 GB, free: 15.68 MB / 1.326 GB Notification: Performance of SimCode: time 1.502e-06/1.277, allocations: 0 / 1.641 GB, free: 15.68 MB / 1.326 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.06715/1.344, allocations: 35.81 MB / 1.676 GB, free: 12.34 MB / 1.357 GB Notification: Performance of buildModelFMU: Generate platform static: time 10.48/11.82, allocations: 20.48 kB / 1.676 GB, free: 12.32 MB / 1.357 GB " [Timeout remaining time 288] (rm -f Buildings_12_Buildings.Fluid.Examples.Performance.Example4.pipe ; mkfifo Buildings_12_Buildings.Fluid.Examples.Performance.Example4.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.Examples.Performance.Example4.pipe >> ../files/Buildings_12_Buildings.Fluid.Examples.Performance.Example4.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Buildings_12_Buildings.Fluid.Examples.Performance.Example4_res.mat --tempDir=temp_Buildings_12_Buildings_Fluid_Examples_Performance_Example4_fmu --startTime=0 --stopTime=20 --stepSize=0.008 --timeout=400 --tolerance=1e-06 Buildings_12_Buildings_Fluid_Examples_Performance_Example4.fmu > Buildings_12_Buildings.Fluid.Examples.Performance.Example4.pipe 2>&1) [Timeout 420.0] [Calling os._exit(0), Time elapsed: 17.81256144301733] Failed to read output from testmodel.py, exit status != 0: 11.98038700997131 11.996728432 10.807556231 Calling exit ...