Running: ./testmodel.py --libraries=/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses.conf.json loadFile("/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) loadFile("/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) loadFile("/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) loadFile("/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo", uses=false) Using package ModelicaTest with version 4.0.0 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo) Using package ModelicaServices with version 4.0.0 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo) Using package Modelica with version 4.0.0 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo) Using package Complex with version 4.0.0 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo) Running command: translateModel(ModelicaTest.MultiBody.Forces.ForceWithTwoMasses,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|revolute.phi|revolute.w",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses") translateModel(ModelicaTest.MultiBody.Forces.ForceWithTwoMasses,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|revolute.phi|revolute.w",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses") Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00152/0.00152, allocations: 174.2 kB / 17.41 MB, free: 4.41 MB / 13.93 MB Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.433/1.433, allocations: 225.7 MB / 243.9 MB, free: 10.19 MB / 202.7 MB Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00089/0.0008901, allocations: 99.75 kB / 295.1 MB, free: 9.707 MB / 234.7 MB Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/converted-libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo): time 0.3546/0.3546, allocations: 44.32 MB / 390.5 MB, free: 38.37 MB / 298.7 MB Notification: Performance of FrontEnd - loaded program: time 0.0003027/0.0003028, allocations: 8 kB / 463.1 MB, free: 460 kB / 330.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.2949/0.2952, allocations: 61.9 MB / 0.5127 GB, free: 37.93 MB / 378.7 MB Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Forces.ForceWithTwoMasses): time 0.02288/0.3181, allocations: 31.62 MB / 0.5436 GB, free: 15.55 MB / 378.7 MB Notification: Performance of NFInst.instExpressions: time 0.01724/0.3354, allocations: 10.76 MB / 0.5541 GB, free: 6.746 MB / 378.7 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.006575/0.342, allocations: 147.1 kB / 0.5543 GB, free: 6.723 MB / 378.7 MB Notification: Performance of NFTyping.typeComponents: time 0.001391/0.3435, allocations: 381.1 kB / 0.5546 GB, free: 6.578 MB / 378.7 MB Notification: Performance of NFTyping.typeBindings: time 0.004162/0.3476, allocations: 1.606 MB / 0.5562 GB, free: 5.887 MB / 378.7 MB Notification: Performance of NFTyping.typeClassSections: time 0.001467/0.3491, allocations: 0.6345 MB / 0.5568 GB, free: 5.637 MB / 378.7 MB Notification: Performance of NFFlatten.flatten: time 0.006894/0.356, allocations: 5.701 MB / 0.5624 GB, free: 3.957 MB / 378.7 MB Notification: Performance of NFFlatten.resolveConnections: time 0.005164/0.3612, allocations: 3.823 MB / 0.5661 GB, free: 1.953 MB / 378.7 MB Notification: Performance of NFEvalConstants.evaluate: time 0.002241/0.3635, allocations: 1.149 MB / 0.5672 GB, free: 1.57 MB / 378.7 MB Notification: Performance of NFSimplifyModel.simplify: time 0.002756/0.3663, allocations: 1.792 MB / 0.569 GB, free: 1.027 MB / 378.7 MB Notification: Performance of NFPackage.collectConstants: time 0.0005201/0.3668, allocations: 122.3 kB / 0.5691 GB, free: 1.027 MB / 378.7 MB Notification: Performance of NFFlatten.collectFunctions: time 0.002458/0.3693, allocations: 1.099 MB / 0.5702 GB, free: 0.7617 MB / 378.7 MB Notification: Performance of NFScalarize.scalarize: time 0.002002/0.3713, allocations: 1.515 MB / 0.5717 GB, free: 216 kB / 378.7 MB Notification: Performance of NFVerifyModel.verify: time 0.002723/0.374, allocations: 1.755 MB / 0.5734 GB, free: 14.83 MB / 394.7 MB Notification: Performance of NFConvertDAE.convert: time 0.008792/0.3828, allocations: 5.792 MB / 0.579 GB, free: 9.023 MB / 394.7 MB Notification: Performance of FrontEnd - DAE generated: time 7.063e-06/0.3829, allocations: 3.938 kB / 0.579 GB, free: 9.02 MB / 394.7 MB Notification: Performance of FrontEnd: time 1.903e-06/0.3829, allocations: 0 / 0.579 GB, free: 9.02 MB / 394.7 MB Notification: Performance of Transformations before backend: time 0.0001942/0.3831, allocations: 0 / 0.579 GB, free: 9.02 MB / 394.7 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1319 * Number of variables: 1319 Notification: Performance of Generate backend data structure: time 0.008255/0.3914, allocations: 3.477 MB / 0.5824 GB, free: 5.477 MB / 394.7 MB Notification: Performance of prepare preOptimizeDAE: time 4.084e-05/0.3914, allocations: 8.031 kB / 0.5824 GB, free: 5.469 MB / 394.7 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01505/0.4065, allocations: 2.496 MB / 0.5849 GB, free: 2.965 MB / 394.7 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.005529/0.412, allocations: 2.39 MB / 0.5872 GB, free: 0.5117 MB / 394.7 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001443/0.4122, allocations: 193.3 kB / 0.5874 GB, free: 328 kB / 394.7 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0007785/0.413, allocations: 279.6 kB / 0.5877 GB, free: 48 kB / 394.7 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.01504/0.4281, allocations: 8.576 MB / 0.596 GB, free: 6.844 MB / 410.7 MB Notification: Performance of preOpt findStateOrder (simulation): time 0.0001248/0.4282, allocations: 39.66 kB / 0.5961 GB, free: 6.805 MB / 410.7 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003762/0.4286, allocations: 131.9 kB / 0.5962 GB, free: 6.676 MB / 410.7 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.00276/0.4314, allocations: 1.735 MB / 0.5979 GB, free: 4.941 MB / 410.7 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01407/0.4455, allocations: 7.272 MB / 0.605 GB, free: 13.66 MB / 426.7 MB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.04298/0.4885, allocations: 34.21 MB / 0.6384 GB, free: 10.37 MB / 458.7 MB Notification: Performance of preOpt comSubExp (simulation): time 0.008472/0.497, allocations: 3.509 MB / 0.6418 GB, free: 6.715 MB / 458.7 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.002268/0.4993, allocations: 1.709 MB / 0.6435 GB, free: 4.992 MB / 458.7 MB Notification: Performance of preOpt evalFunc (simulation): time 0.01137/0.5107, allocations: 7.428 MB / 0.6508 GB, free: 13.29 MB / 474.7 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.393e-05/0.5108, allocations: 47.5 kB / 0.6508 GB, free: 13.24 MB / 474.7 MB Notification: Performance of pre-optimization done (n=151): time 4.789e-06/0.5109, allocations: 3.938 kB / 0.6508 GB, free: 13.23 MB / 474.7 MB Notification: Performance of matching and sorting (n=188): time 0.06329/0.5742, allocations: 19.94 MB / 0.6703 GB, free: 9.129 MB / 490.7 MB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001267/0.5743, allocations: 197.2 kB / 0.6705 GB, free: 8.895 MB / 490.7 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005143/0.5795, allocations: 3.711 MB / 0.6741 GB, free: 5.191 MB / 490.7 MB Notification: Performance of collectPreVariables (initialization): time 0.0003724/0.5799, allocations: 53.69 kB / 0.6741 GB, free: 5.133 MB / 490.7 MB Notification: Performance of collectInitialEqns (initialization): time 0.002091/0.582, allocations: 2.799 MB / 0.6769 GB, free: 2.297 MB / 490.7 MB Notification: Performance of collectInitialBindings (initialization): time 0.0008228/0.5828, allocations: 0.7212 MB / 0.6776 GB, free: 1.566 MB / 490.7 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002424/0.5831, allocations: 124 kB / 0.6777 GB, free: 1.445 MB / 490.7 MB Notification: Performance of setup shared object (initialization): time 0.0003228/0.5834, allocations: 0.5581 MB / 0.6782 GB, free: 0.8789 MB / 490.7 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.2373/0.8207, allocations: 2.187 MB / 0.6804 GB, free: 131.1 MB / 490.7 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.00544/0.8262, allocations: 5.741 MB / 0.686 GB, free: 125.7 MB / 490.7 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.009341/0.8356, allocations: 8.568 MB / 0.6943 GB, free: 118.6 MB / 490.7 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001214/0.8358, allocations: 34.91 kB / 0.6944 GB, free: 118.6 MB / 490.7 MB Notification: Performance of matching and sorting (n=782) (initialization): time 0.01795/0.8537, allocations: 9.165 MB / 0.7033 GB, free: 115.5 MB / 490.7 MB Notification: Performance of prepare postOptimizeDAE: time 9.497e-05/0.8539, allocations: 59.41 kB / 0.7034 GB, free: 115.5 MB / 490.7 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001547/0.8541, allocations: 126.9 kB / 0.7035 GB, free: 115.5 MB / 490.7 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.005683/0.8598, allocations: 1.69 MB / 0.7052 GB, free: 115.2 MB / 490.7 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004827/0.8646, allocations: 1.318 MB / 0.7064 GB, free: 115.1 MB / 490.7 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01418/0.8788, allocations: 9.313 MB / 0.7155 GB, free: 110.8 MB / 490.7 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005034/0.8839, allocations: 310.9 kB / 0.7158 GB, free: 110.7 MB / 490.7 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001209/0.8851, allocations: 359.5 kB / 0.7162 GB, free: 110.7 MB / 490.7 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 570 * Number of states: 0 () * Number of discrete variables: 36 (FixedTranslation2.color[3],FixedTranslation2.color[2],FixedTranslation2.color[1],force.massColor[3],force.massColor[2],force.massColor[1],force.color_b[3],force.color_b[2],force.color_b[1],force.color_a[3],force.color_a[2],force.color_a[1],FixedTranslation1.color[3],FixedTranslation1.color[2],FixedTranslation1.color[1],BodyBox1.color[3],BodyBox1.color[2],BodyBox1.color[1],BodyBox1.body.sphereColor[3],BodyBox1.body.sphereColor[2],BodyBox1.body.sphereColor[1],revolute.cylinderColor[3],revolute.cylinderColor[2],revolute.cylinderColor[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 (714): * Single equations (assignments): 710 * Array equations: 3 * 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): 1 system {(2,43,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.004458/0.8896, allocations: 1.897 MB / 0.718 GB, free: 109.8 MB / 490.7 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00087/0.8905, allocations: 330.7 kB / 0.7183 GB, free: 109.8 MB / 490.7 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01004/0.9005, allocations: 4.161 MB / 0.7224 GB, free: 108.4 MB / 490.7 MB Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.027e-05/0.9006, allocations: 19.75 kB / 0.7224 GB, free: 108.4 MB / 490.7 MB Notification: Performance of postOpt constantLinearSystem (simulation): time 2.255e-05/0.9007, allocations: 7.656 kB / 0.7224 GB, free: 108.4 MB / 490.7 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.285e-05/0.9007, allocations: 11.88 kB / 0.7224 GB, free: 108.4 MB / 490.7 MB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01728/0.918, allocations: 8.569 MB / 0.7308 GB, free: 105.5 MB / 490.7 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.138e-05/0.9181, allocations: 0 / 0.7308 GB, free: 105.5 MB / 490.7 MB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001246/0.9193, allocations: 248.6 kB / 0.731 GB, free: 105.4 MB / 490.7 MB Notification: Performance of postOpt tearingSystem (simulation): time 0.005051/0.9244, allocations: 1.46 MB / 0.7325 GB, free: 105.2 MB / 490.7 MB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002639/0.9247, allocations: 34.59 kB / 0.7325 GB, free: 105.1 MB / 490.7 MB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01096/0.9357, allocations: 8.607 MB / 0.7409 GB, free: 97.95 MB / 490.7 MB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.645e-06/0.9357, allocations: 1.859 kB / 0.7409 GB, free: 97.95 MB / 490.7 MB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01088/0.9466, allocations: 6.738 MB / 0.7475 GB, free: 91.74 MB / 490.7 MB Notification: Performance of postOpt removeConstants (simulation): time 0.0009311/0.9476, allocations: 376.7 kB / 0.7479 GB, free: 91.35 MB / 490.7 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003816/0.948, allocations: 31.98 kB / 0.7479 GB, free: 91.32 MB / 490.7 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001275/0.9492, allocations: 95.83 kB / 0.748 GB, free: 91.22 MB / 490.7 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003621/0.9496, allocations: 117.9 kB / 0.7481 GB, free: 91.11 MB / 490.7 MB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001246/0.9498, allocations: 52.84 kB / 0.7481 GB, free: 91.06 MB / 490.7 MB Notification: Performance of sorting global known variables: time 0.00283/0.9526, allocations: 2.292 MB / 0.7504 GB, free: 88.78 MB / 490.7 MB Notification: Performance of sort global known variables: time 3.4e-07/0.9526, allocations: 4 kB / 0.7504 GB, free: 88.78 MB / 490.7 MB Notification: Performance of remove unused functions: time 0.004626/0.9572, allocations: 0.9983 MB / 0.7514 GB, free: 87.79 MB / 490.7 MB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 4 * Number of states: 2 (revolute.phi,revolute.w) * 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 (130): * Single equations (assignments): 126 * Array equations: 3 * 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): 1 system {(1,36,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of Backend phase and start with SimCode phase: time 0.0003991/0.9577, allocations: 175.4 kB / 0.7515 GB, free: 87.62 MB / 490.7 MB Notification: Performance of simCode: created initialization part: time 0.007039/0.9647, allocations: 5.38 MB / 0.7568 GB, free: 82.25 MB / 490.7 MB Notification: Performance of simCode: created event and clocks part: time 6.983e-06/0.9647, allocations: 0 / 0.7568 GB, free: 82.25 MB / 490.7 MB Notification: Performance of simCode: created simulation system equations: time 0.00203/0.9668, allocations: 1.807 MB / 0.7585 GB, free: 80.43 MB / 490.7 MB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002445/0.9692, allocations: 362.9 kB / 0.7589 GB, free: 80.07 MB / 490.7 MB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01219/0.9815, allocations: 10.43 MB / 0.7691 GB, free: 69.62 MB / 490.7 MB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002309/0.9838, allocations: 2.969 MB / 0.772 GB, free: 66.61 MB / 490.7 MB Notification: Performance of simCode: alias equations: time 0.004111/0.9879, allocations: 1.811 MB / 0.7737 GB, free: 64.79 MB / 490.7 MB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006003/0.9886, allocations: 223.4 kB / 0.774 GB, free: 64.57 MB / 490.7 MB Notification: Performance of SimCode: time 7.32e-07/0.9886, allocations: 0 / 0.774 GB, free: 64.57 MB / 490.7 MB Notification: Performance of Templates: time 0.06153/1.05, allocations: 37.17 MB / 0.8103 GB, free: 27.55 MB / 490.7 MB make -j1 -f ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses.makefile (rm -f ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses.pipe ; mkfifo ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses.pipe ; head -c 1048576 < ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses.pipe >> ../files/ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses.sim & ./ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses -abortSlowSimulation -alarm=480 -emit_protected -lv LOG_STATS > ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses.pipe 2>&1) diffSimulationResults("ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/ModelicaTest/MultiBody/Forces/ForceWithTwoMasses/ForceWithTwoMasses.csv","../files/ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) Reference file matches