Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Forces.Damper2.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001212/0.001212, allocations: 105 kB / 19.74 MB, free: 2.453 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001316/0.001316, allocations: 214.1 kB / 22.92 MB, free: 5.195 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.308/1.308, allocations: 230.2 MB / 256.2 MB, free: 8.57 MB / 206.1 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo): time 0.2004/0.2004, allocations: 46.89 MB / 359.3 MB, free: 4.965 MB / 286.1 MB " [Timeout remaining time 180] Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo) Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo) Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo) Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo) Running command: "" <> buildModelFMU(ModelicaTest.MultiBody.Forces.Damper2,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Forces_Damper2",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(ModelicaTest.MultiBody.Forces.Damper2,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Forces_Damper2",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660] "Warning: Requested package Modelica of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions. Notification: Performance of FrontEnd - loaded program: time 0.002125/0.002125, allocations: 83.86 kB / 0.494 GB, free: 9.094 MB / 366.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.2578/0.2599, allocations: 65.98 MB / 0.5584 GB, free: 5.215 MB / 398.1 MB Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Forces.Damper2): time 0.01742/0.2773, allocations: 16.26 MB / 0.5743 GB, free: 4.891 MB / 414.1 MB Notification: Performance of NFInst.instExpressions: time 0.01012/0.2874, allocations: 5.059 MB / 0.5792 GB, free: 15.81 MB / 430.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.002242/0.2897, allocations: 99.75 kB / 0.5793 GB, free: 15.71 MB / 430.1 MB Notification: Performance of NFTyping.typeComponents: time 0.00947/0.2991, allocations: 5.241 MB / 0.5845 GB, free: 10.46 MB / 430.1 MB Notification: Performance of NFTyping.typeBindings: time 0.006469/0.3056, allocations: 2.555 MB / 0.5869 GB, free: 7.895 MB / 430.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.002812/0.3084, allocations: 1.193 MB / 0.5881 GB, free: 6.699 MB / 430.1 MB Notification: Performance of NFFlatten.flatten: time 0.009194/0.3176, allocations: 6.705 MB / 0.5947 GB, free: 15.98 MB / 446.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.006138/0.3237, allocations: 4.704 MB / 0.5993 GB, free: 11.2 MB / 446.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.004178/0.3279, allocations: 2.609 MB / 0.6018 GB, free: 8.578 MB / 446.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.00507/0.333, allocations: 3.965 MB / 0.6057 GB, free: 4.602 MB / 446.1 MB Notification: Performance of NFPackage.collectConstants: time 0.00118/0.3342, allocations: 0.5781 MB / 0.6062 GB, free: 4.023 MB / 446.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.00229/0.3365, allocations: 1.292 MB / 0.6075 GB, free: 2.73 MB / 446.1 MB Notification: Performance of NFScalarize.scalarize: time 0.002974/0.3394, allocations: 3.307 MB / 0.6107 GB, free: 15.41 MB / 462.1 MB Notification: Performance of NFVerifyModel.verify: time 0.003785/0.3432, allocations: 3.678 MB / 0.6143 GB, free: 11.71 MB / 462.1 MB Notification: Performance of NFConvertDAE.convert: time 0.01155/0.3548, allocations: 11.19 MB / 0.6252 GB, free: 488 kB / 462.1 MB Notification: Performance of FrontEnd - DAE generated: time 4.017e-06/0.3548, allocations: 0 / 0.6252 GB, free: 488 kB / 462.1 MB Notification: Performance of FrontEnd: time 1.252e-06/0.3548, allocations: 4 kB / 0.6253 GB, free: 484 kB / 462.1 MB Notification: Performance of Transformations before backend: time 0.000225/0.355, allocations: 0 / 0.6253 GB, free: 484 kB / 462.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 2522 * Number of variables: 2522 Notification: Performance of Generate backend data structure: time 0.0137/0.3687, allocations: 7.901 MB / 0.633 GB, free: 8.469 MB / 478.1 MB Notification: Performance of prepare preOptimizeDAE: time 3.674e-05/0.3687, allocations: 8.031 kB / 0.633 GB, free: 8.461 MB / 478.1 MB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001725/0.3705, allocations: 1.19 MB / 0.6341 GB, free: 7.262 MB / 478.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009889/0.3804, allocations: 2.664 MB / 0.6367 GB, free: 4.59 MB / 478.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.007638/0.388, allocations: 4.272 MB / 0.6409 GB, free: 264 kB / 478.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003717/0.3884, allocations: 439.1 kB / 0.6413 GB, free: 15.82 MB / 494.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.001279/0.3896, allocations: 0.5544 MB / 0.6419 GB, free: 15.27 MB / 494.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.03852/0.4282, allocations: 19.79 MB / 0.6612 GB, free: 10.35 MB / 0.4981 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0002013/0.4284, allocations: 67.44 kB / 0.6613 GB, free: 10.29 MB / 0.4981 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0008539/0.4292, allocations: 271.7 kB / 0.6615 GB, free: 10.02 MB / 0.4981 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.004767/0.434, allocations: 3.149 MB / 0.6646 GB, free: 6.867 MB / 0.4981 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03513/0.4691, allocations: 15.92 MB / 0.6801 GB, free: 6.914 MB / 0.5137 GB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.2849/0.754, allocations: 63.93 MB / 0.7426 GB, free: 111.4 MB / 0.5606 GB Notification: Performance of preOpt comSubExp (simulation): time 0.01468/0.7687, allocations: 6.211 MB / 0.7486 GB, free: 110.8 MB / 0.5606 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.002279/0.771, allocations: 1.932 MB / 0.7505 GB, free: 110.7 MB / 0.5606 GB Notification: Performance of preOpt evalFunc (simulation): time 0.01011/0.7811, allocations: 9.222 MB / 0.7595 GB, free: 107.3 MB / 0.5606 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01177/0.7928, allocations: 4.192 MB / 0.7636 GB, free: 105.8 MB / 0.5606 GB Notification: Performance of pre-optimization done (n=260): time 4.338e-06/0.7928, allocations: 1.969 kB / 0.7636 GB, free: 105.8 MB / 0.5606 GB Notification: Performance of matching and sorting (n=294): time 0.04632/0.8392, allocations: 21.96 MB / 0.7851 GB, free: 86.43 MB / 0.5606 GB Notification: Performance of inlineWhenForInitialization (initialization): time 4.604e-05/0.8392, allocations: 175.1 kB / 0.7852 GB, free: 86.23 MB / 0.5606 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005391/0.8446, allocations: 5.805 MB / 0.7909 GB, free: 80.57 MB / 0.5606 GB Notification: Performance of collectPreVariables (initialization): time 0.0002935/0.8449, allocations: 69.7 kB / 0.791 GB, free: 80.49 MB / 0.5606 GB Notification: Performance of collectInitialEqns (initialization): time 0.002246/0.8471, allocations: 5.133 MB / 0.796 GB, free: 75.63 MB / 0.5606 GB Notification: Performance of collectInitialBindings (initialization): time 0.0006941/0.8478, allocations: 1.18 MB / 0.7971 GB, free: 74.47 MB / 0.5606 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.001453/0.8493, allocations: 1.815 MB / 0.7989 GB, free: 72.64 MB / 0.5606 GB Notification: Performance of setup shared object (initialization): time 3.414e-05/0.8493, allocations: 301.1 kB / 0.7992 GB, free: 72.34 MB / 0.5606 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.003107/0.8524, allocations: 2.648 MB / 0.8018 GB, free: 69.69 MB / 0.5606 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.004562/0.857, allocations: 8.209 MB / 0.8098 GB, free: 58.88 MB / 0.5606 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.008125/0.8651, allocations: 11.82 MB / 0.8213 GB, free: 44.61 MB / 0.5606 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.13e-05/0.8652, allocations: 56 kB / 0.8214 GB, free: 44.56 MB / 0.5606 GB Notification: Performance of matching and sorting (n=1200) (initialization): time 0.01199/0.8772, allocations: 10.61 MB / 0.8318 GB, free: 33.94 MB / 0.5606 GB Notification: Performance of prepare postOptimizeDAE: time 9.057e-05/0.8773, allocations: 117.7 kB / 0.8319 GB, free: 33.82 MB / 0.5606 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001297/0.8774, allocations: 199.9 kB / 0.8321 GB, free: 33.62 MB / 0.5606 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0001595/0.8776, allocations: 260 kB / 0.8323 GB, free: 33.37 MB / 0.5606 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005252/0.8828, allocations: 2.204 MB / 0.8345 GB, free: 31.16 MB / 0.5606 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001692/0.883, allocations: 390.5 kB / 0.8348 GB, free: 30.78 MB / 0.5606 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004635/0.8876, allocations: 475.5 kB / 0.8353 GB, free: 30.31 MB / 0.5606 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004582/0.8881, allocations: 0.5426 MB / 0.8358 GB, free: 29.77 MB / 0.5606 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 895 * Number of states: 0 () * Number of discrete variables: 83 (trapezoid.count,$PRE.trapezoid.count,trapezoid.T_start,$PRE.trapezoid.T_start,$whenCondition1,force2.forceArrow.twoHeadedArrow,force2.forceArrow.headAtOrigin,force1.forceArrow.twoHeadedArrow,force1.forceArrow.headAtOrigin,force.forceArrow.twoHeadedArrow,force.forceArrow.headAtOrigin,fixedTranslation1.color[3],fixedTranslation1.color[2],fixedTranslation1.color[1],fixedTranslation.color[3],fixedTranslation.color[2],fixedTranslation.color[1],body2.sphereColor[3],body2.sphereColor[2],body2.sphereColor[1],force2.connectionLineColor[3],force2.connectionLineColor[2],force2.connectionLineColor[1],force2.forceColor[3],force2.forceColor[2],force2.forceColor[1],prismatic2.boxColor[3],prismatic2.boxColor[2],prismatic2.boxColor[1],damper2.color_b[3],damper2.color_b[2],damper2.color_b[1],damper2.color_a[3],damper2.color_a[2],damper2.color_a[1],body1.sphereColor[3],body1.sphereColor[2],body1.sphereColor[1],force1.connectionLineColor[3],force1.connectionLineColor[2],force1.connectionLineColor[1],force1.forceColor[3],force1.forceColor[2],force1.forceColor[1],prismatic1.boxColor[3],prismatic1.boxColor[2],prismatic1.boxColor[1],damper1.color_b[3],damper1.color_b[2],damper1.color_b[1],damper1.color_a[3],damper1.color_a[2],damper1.color_a[1],body.sphereColor[3],body.sphereColor[2],body.sphereColor[1],force.connectionLineColor[3],force.connectionLineColor[2],force.connectionLineColor[1],force.forceColor[3],force.forceColor[2],force.forceColor[1],prismatic.boxColor[3],prismatic.boxColor[2],prismatic.boxColor[1],damper.color_b[3],damper.color_b[2],damper.color_b[1],damper.color_a[3],damper.color_a[2],damper.color_a[1],world.gravityArrowColor[3],world.gravityArrowColor[2],world.gravityArrowColor[1],world.axisColor_x[3],world.axisColor_x[2],world.axisColor_x[1],world.groundColor[3],world.groundColor[2],world.groundColor[1],world.gravitySphereColor[3],world.gravitySphereColor[2],world.gravitySphereColor[1]) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (1175): * Single equations (assignments): 1171 * Array equations: 3 * Algorithm blocks: 1 * 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.003084/0.8912, allocations: 3.148 MB / 0.8389 GB, free: 26.61 MB / 0.5606 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005572/0.8917, allocations: 0.5433 MB / 0.8394 GB, free: 26.07 MB / 0.5606 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004116/0.8958, allocations: 3.067 MB / 0.8424 GB, free: 22.98 MB / 0.5606 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.326e-05/0.8958, allocations: 28 kB / 0.8424 GB, free: 22.95 MB / 0.5606 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 9.618e-06/0.8959, allocations: 8 kB / 0.8424 GB, free: 22.95 MB / 0.5606 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.843e-05/0.8959, allocations: 15.89 kB / 0.8425 GB, free: 22.93 MB / 0.5606 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01373/0.9096, allocations: 12.26 MB / 0.8544 GB, free: 10.19 MB / 0.5606 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.755e-05/0.9097, allocations: 32.47 kB / 0.8545 GB, free: 10.16 MB / 0.5606 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00195/0.9116, allocations: 0.5966 MB / 0.8551 GB, free: 9.562 MB / 0.5606 GB Notification: Performance of postOpt tearingSystem (simulation): time 3.549e-05/0.9116, allocations: 44 kB / 0.8551 GB, free: 9.52 MB / 0.5606 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001498/0.9118, allocations: 87.98 kB / 0.8552 GB, free: 9.434 MB / 0.5606 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.708e-05/0.9118, allocations: 63.8 kB / 0.8552 GB, free: 9.371 MB / 0.5606 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.721e-05/0.9118, allocations: 51.69 kB / 0.8553 GB, free: 9.32 MB / 0.5606 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005433/0.9173, allocations: 5.544 MB / 0.8607 GB, free: 3.234 MB / 0.5606 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001021/0.9183, allocations: 0.6105 MB / 0.8613 GB, free: 2.602 MB / 0.5606 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0008008/0.9191, allocations: 95.23 kB / 0.8614 GB, free: 2.512 MB / 0.5606 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00212/0.9212, allocations: 155.8 kB / 0.8615 GB, free: 2.359 MB / 0.5606 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002919/0.9215, allocations: 283.9 kB / 0.8618 GB, free: 2.082 MB / 0.5606 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001599/0.9217, allocations: 120 kB / 0.8619 GB, free: 1.965 MB / 0.5606 GB Notification: Performance of sorting global known variables: time 0.005928/0.9276, allocations: 3.594 MB / 0.8654 GB, free: 14.4 MB / 0.5762 GB Notification: Performance of sort global known variables: time 2.6e-07/0.9276, allocations: 0 / 0.8654 GB, free: 14.4 MB / 0.5762 GB Notification: Performance of remove unused functions: time 0.00785/0.9354, allocations: 1.41 MB / 0.8668 GB, free: 13 MB / 0.5762 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 142 * Number of states: 7 (prismatic.s,prismatic.v,prismatic1.s,prismatic1.v,heatCapacitor.T,prismatic2.s,prismatic2.v) * Number of discrete variables: 3 ($whenCondition1,trapezoid.T_start,trapezoid.count) * Number of discrete states: 1 (trapezoid.count) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (278): * Single equations (assignments): 273 * Array equations: 3 * Algorithm blocks: 0 * Record equations: 0 * When equations: 2 * 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.01001/0.9454, allocations: 6.267 MB / 0.8729 GB, free: 6.18 MB / 0.5762 GB Notification: Performance of simCode: created initialization part: time 0.01065/0.9561, allocations: 5.901 MB / 0.8787 GB, free: 304 kB / 0.5762 GB Notification: Performance of simCode: created event and clocks part: time 1.888e-05/0.9561, allocations: 4 kB / 0.8787 GB, free: 300 kB / 0.5762 GB Notification: Performance of simCode: created simulation system equations: time 0.003096/0.9592, allocations: 1.558 MB / 0.8802 GB, free: 14.75 MB / 0.5919 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005012/0.9642, allocations: 0.7749 MB / 0.881 GB, free: 13.99 MB / 0.5919 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1059/1.07, allocations: 67.86 MB / 0.9472 GB, free: 92 kB / 0.6544 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00759/1.078, allocations: 4.764 MB / 0.9519 GB, free: 11.3 MB / 0.67 GB Notification: Performance of simCode: alias equations: time 0.005813/1.084, allocations: 2.575 MB / 0.9544 GB, free: 8.715 MB / 0.67 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004284/1.088, allocations: 3.155 MB / 0.9575 GB, free: 5.559 MB / 0.67 GB Notification: Performance of SimCode: time 1.333e-06/1.088, allocations: 0 / 0.9575 GB, free: 5.559 MB / 0.67 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.3387/1.427, allocations: 91.06 MB / 1.046 GB, free: 244.5 MB / 0.7012 GB Notification: Performance of buildModelFMU: Generate platform static: time 18.48/19.9, allocations: 6.797 kB / 1.046 GB, free: 244.5 MB / 0.7012 GB " [Timeout remaining time 640] (rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Forces.Damper2.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Forces.Damper2.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Forces.Damper2.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Forces.Damper2.sim & python3 -m fmpy simulate --output-file ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Forces.Damper2_res.csv --start-time 0 --stop-time 7 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.00137336 ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Forces_Damper2.fmu > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Forces.Damper2.pipe 2>&1) [Timeout 52.5] [Calling os._exit(0), Time elapsed: 22.510092825003085]