Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses.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.001898/0.001898, allocations: 82.25 kB / 21.25 MB, free: 0.5469 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.002053/0.002053, allocations: 159.1 kB / 24.5 MB, free: 3.719 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.435/1.435, allocations: 177.1 MB / 204.7 MB, free: 8.973 MB / 190.1 MB " [Timeout remaining time 178] 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: translateModel(Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|revolute1.phi|revolute1.w|revolute2.phi|revolute2.w",fileNamePrefix="Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses") translateModel(Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|revolute1.phi|revolute1.w|revolute2.phi|revolute2.w",fileNamePrefix="Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses") [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 0.001995/0.001995, allocations: 61.05 kB / 325.5 MB, free: 200 kB / 286.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.09398/0.09598, allocations: 53.38 MB / 378.9 MB, free: 15.5 MB / 350.1 MB Notification: Performance of NFInst.instantiate(Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses): time 0.01836/0.1143, allocations: 14.95 MB / 393.9 MB, free: 0.4922 MB / 350.1 MB Notification: Performance of NFInst.instExpressions: time 0.01167/0.126, allocations: 5.265 MB / 399.1 MB, free: 11.21 MB / 366.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.001927/0.1279, allocations: 139.3 kB / 399.3 MB, free: 11.08 MB / 366.1 MB Notification: Performance of NFTyping.typeComponents: time 0.008157/0.1361, allocations: 4.256 MB / 403.5 MB, free: 6.809 MB / 366.1 MB Notification: Performance of NFTyping.typeBindings: time 0.006713/0.1428, allocations: 2.801 MB / 406.3 MB, free: 3.996 MB / 366.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.003184/0.146, allocations: 1.478 MB / 407.8 MB, free: 2.516 MB / 366.1 MB Notification: Performance of NFFlatten.flatten: time 0.01292/0.1589, allocations: 8.656 MB / 416.5 MB, free: 9.844 MB / 382.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.006634/0.1655, allocations: 4.39 MB / 420.8 MB, free: 5.371 MB / 382.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.00459/0.1701, allocations: 2.706 MB / 423.5 MB, free: 2.656 MB / 382.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.006204/0.1763, allocations: 3.937 MB / 427.5 MB, free: 14.7 MB / 398.1 MB Notification: Performance of NFPackage.collectConstants: time 0.001265/0.1776, allocations: 0.5352 MB / 428 MB, free: 14.17 MB / 398.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.00307/0.1807, allocations: 1.506 MB / 429.5 MB, free: 12.66 MB / 398.1 MB Notification: Performance of NFScalarize.scalarize: time 0.003682/0.1844, allocations: 3.424 MB / 433 MB, free: 9.23 MB / 398.1 MB Notification: Performance of NFVerifyModel.verify: time 0.003981/0.1883, allocations: 2.746 MB / 435.7 MB, free: 6.469 MB / 398.1 MB Notification: Performance of NFConvertDAE.convert: time 0.01325/0.2016, allocations: 11.25 MB / 446.9 MB, free: 11.18 MB / 414.1 MB Notification: Performance of FrontEnd - DAE generated: time 5.34e-06/0.2016, allocations: 0 / 446.9 MB, free: 11.18 MB / 414.1 MB Notification: Performance of FrontEnd: time 1.513e-06/0.2016, allocations: 3.938 kB / 447 MB, free: 11.17 MB / 414.1 MB Notification: Performance of Transformations before backend: time 0.0002587/0.2019, allocations: 0 / 447 MB, free: 11.17 MB / 414.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 2303 * Number of variables: 2303 Notification: Performance of Generate backend data structure: time 0.01987/0.2217, allocations: 8.322 MB / 455.3 MB, free: 2.77 MB / 414.1 MB Notification: Performance of prepare preOptimizeDAE: time 4.438e-05/0.2218, allocations: 15.98 kB / 455.3 MB, free: 2.754 MB / 414.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.03239/0.2542, allocations: 3.975 MB / 459.3 MB, free: 14.77 MB / 430.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.01332/0.2675, allocations: 5.22 MB / 464.5 MB, free: 9.461 MB / 430.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003172/0.2678, allocations: 373.5 kB / 464.8 MB, free: 9.094 MB / 430.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.001257/0.269, allocations: 0.5113 MB / 465.4 MB, free: 8.582 MB / 430.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.2287/0.4978, allocations: 16.44 MB / 481.8 MB, free: 73.59 MB / 430.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 0.0003629/0.4981, allocations: 74.56 kB / 481.9 MB, free: 73.56 MB / 430.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00113/0.4992, allocations: 241.4 kB / 482.1 MB, free: 73.45 MB / 430.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.008122/0.5074, allocations: 2.927 MB / 485 MB, free: 72.93 MB / 430.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03639/0.5438, allocations: 13.69 MB / 498.7 MB, free: 67.18 MB / 430.1 MB 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.05992/0.6037, allocations: 59.93 MB / 0.5456 GB, free: 6.676 MB / 430.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.02034/0.624, allocations: 7.388 MB / 0.5528 GB, free: 15.34 MB / 446.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.006208/0.6302, allocations: 3.972 MB / 0.5567 GB, free: 11.35 MB / 446.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.03288/0.6631, allocations: 16.26 MB / 0.5725 GB, free: 11.2 MB / 462.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.532e-05/0.6632, allocations: 60.56 kB / 0.5726 GB, free: 11.13 MB / 462.1 MB Notification: Performance of pre-optimization done (n=290): time 6.493e-06/0.6632, allocations: 0 / 0.5726 GB, free: 11.13 MB / 462.1 MB Notification: Performance of matching and sorting (n=372): time 0.1839/0.8471, allocations: 50.93 MB / 0.6223 GB, free: 8.543 MB / 0.4981 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001976/0.8473, allocations: 269.8 kB / 0.6226 GB, free: 8.223 MB / 0.4981 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008492/0.8558, allocations: 5.767 MB / 0.6282 GB, free: 2.605 MB / 0.4981 GB Notification: Performance of collectPreVariables (initialization): time 0.0007057/0.8565, allocations: 81.7 kB / 0.6283 GB, free: 2.52 MB / 0.4981 GB Notification: Performance of collectInitialEqns (initialization): time 0.003842/0.8603, allocations: 4.892 MB / 0.6331 GB, free: 13.58 MB / 0.5137 GB Notification: Performance of collectInitialBindings (initialization): time 0.001874/0.8622, allocations: 1.434 MB / 0.6345 GB, free: 12.14 MB / 0.5137 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.002918/0.8651, allocations: 1.914 MB / 0.6363 GB, free: 10.21 MB / 0.5137 GB Notification: Performance of setup shared object (initialization): time 0.0001356/0.8653, allocations: 305.1 kB / 0.6366 GB, free: 9.91 MB / 0.5137 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.007231/0.8725, allocations: 4.161 MB / 0.6407 GB, free: 5.742 MB / 0.5137 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.01606/0.8886, allocations: 9.491 MB / 0.65 GB, free: 9.676 MB / 0.5294 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.03019/0.9188, allocations: 14.5 MB / 0.6641 GB, free: 8.605 MB / 0.545 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.00019/0.919, allocations: 52 kB / 0.6642 GB, free: 8.555 MB / 0.545 GB Notification: Performance of matching and sorting (n=1253) (initialization): time 0.2395/1.158, allocations: 17.4 MB / 0.6812 GB, free: 178.2 MB / 0.545 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001279/1.159, allocations: 82.66 kB / 0.6812 GB, free: 178.2 MB / 0.545 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002345/1.159, allocations: 181.2 kB / 0.6814 GB, free: 178.2 MB / 0.545 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.01413/1.173, allocations: 4.61 MB / 0.6859 GB, free: 178.2 MB / 0.545 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006882/1.18, allocations: 2.123 MB / 0.688 GB, free: 178.2 MB / 0.545 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03037/1.21, allocations: 24.67 MB / 0.7121 GB, free: 167.3 MB / 0.545 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006958/1.217, allocations: 0.5354 MB / 0.7126 GB, free: 167.1 MB / 0.545 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001195/1.218, allocations: 0.5365 MB / 0.7131 GB, free: 167 MB / 0.545 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 825 * Number of states: 0 () * Number of discrete variables: 66 (lineForceWithTwoMasses.massColor[3],lineForceWithTwoMasses.massColor[2],lineForceWithTwoMasses.massColor[1],lineForceWithTwoMasses.color_b[3],lineForceWithTwoMasses.color_b[2],lineForceWithTwoMasses.color_b[1],lineForceWithTwoMasses.color_a[3],lineForceWithTwoMasses.color_a[2],lineForceWithTwoMasses.color_a[1],rod4.color[3],rod4.color[2],rod4.color[1],rod3.color[3],rod3.color[2],rod3.color[1],bodyBox2.color[3],bodyBox2.color[2],bodyBox2.color[1],bodyBox2.body.sphereColor[3],bodyBox2.body.sphereColor[2],bodyBox2.body.sphereColor[1],revolute2.cylinderColor[3],revolute2.cylinderColor[2],revolute2.cylinderColor[1],rod2.color[3],rod2.color[2],rod2.color[1],body2.sphereColor[3],body2.sphereColor[2],body2.sphereColor[1],body1.sphereColor[3],body1.sphereColor[2],body1.sphereColor[1],jointUPS.cylinderColor[3],jointUPS.cylinderColor[2],jointUPS.cylinderColor[1],jointUPS.sphereColor[3],jointUPS.sphereColor[2],jointUPS.sphereColor[1],jointUPS.axisColor[3],jointUPS.axisColor[2],jointUPS.axisColor[1],rod1.color[3],rod1.color[2],rod1.color[1],bodyBox1.color[3],bodyBox1.color[2],bodyBox1.color[1],bodyBox1.body.sphereColor[3],bodyBox1.body.sphereColor[2],bodyBox1.body.sphereColor[1],revolute1.cylinderColor[3],revolute1.cylinderColor[2],revolute1.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 (1133): * Single equations (assignments): 1128 * Array equations: 3 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 2 systems {(1,45,100.0%), (2,50,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.004504/1.223, allocations: 3.12 MB / 0.7162 GB, free: 164.1 MB / 0.545 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001102/1.224, allocations: 0.5448 MB / 0.7167 GB, free: 163.9 MB / 0.545 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01975/1.244, allocations: 10.56 MB / 0.727 GB, free: 153.3 MB / 0.545 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.067e-05/1.244, allocations: 36 kB / 0.7271 GB, free: 153.2 MB / 0.545 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 2.516e-05/1.244, allocations: 17.78 kB / 0.7271 GB, free: 153.2 MB / 0.545 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.302e-05/1.244, allocations: 19.94 kB / 0.7271 GB, free: 153.2 MB / 0.545 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.03199/1.276, allocations: 18.24 MB / 0.7449 GB, free: 135.2 MB / 0.545 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.531e-05/1.276, allocations: 3.938 kB / 0.7449 GB, free: 135.2 MB / 0.545 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002778/1.279, allocations: 0.5422 MB / 0.7454 GB, free: 134.6 MB / 0.545 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.01236/1.291, allocations: 4.252 MB / 0.7496 GB, free: 130.4 MB / 0.545 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0006967/1.292, allocations: 63.94 kB / 0.7497 GB, free: 130.3 MB / 0.545 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02593/1.318, allocations: 22.42 MB / 0.7715 GB, free: 107.8 MB / 0.545 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.164e-06/1.318, allocations: 0 / 0.7715 GB, free: 107.8 MB / 0.545 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02451/1.342, allocations: 15.43 MB / 0.7866 GB, free: 92.63 MB / 0.545 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001262/1.343, allocations: 493.2 kB / 0.7871 GB, free: 92.32 MB / 0.545 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0009935/1.344, allocations: 63.83 kB / 0.7871 GB, free: 92.26 MB / 0.545 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002932/1.347, allocations: 235.6 kB / 0.7874 GB, free: 92.03 MB / 0.545 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0007255/1.348, allocations: 237.9 kB / 0.7876 GB, free: 91.8 MB / 0.545 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002566/1.348, allocations: 91.98 kB / 0.7877 GB, free: 91.71 MB / 0.545 GB Notification: Performance of sorting global known variables: time 0.003643/1.352, allocations: 3.351 MB / 0.791 GB, free: 88.38 MB / 0.545 GB Notification: Performance of sort global known variables: time 8e-08/1.352, allocations: 2.953 kB / 0.791 GB, free: 88.38 MB / 0.545 GB Notification: Performance of remove unused functions: time 0.007317/1.359, allocations: 1.893 MB / 0.7928 GB, free: 86.49 MB / 0.545 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 4 * Number of states: 4 (revolute1.phi,revolute1.w,revolute2.phi,revolute2.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 (272): * Single equations (assignments): 267 * Array equations: 3 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 2 systems {(2,43,100.0%), (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.0006293/1.36, allocations: 219 kB / 0.793 GB, free: 86.27 MB / 0.545 GB Notification: Performance of simCode: created initialization part: time 0.01369/1.374, allocations: 9.901 MB / 0.8027 GB, free: 76.36 MB / 0.545 GB Notification: Performance of simCode: created event and clocks part: time 8.606e-06/1.374, allocations: 4 kB / 0.8027 GB, free: 76.36 MB / 0.545 GB Notification: Performance of simCode: created simulation system equations: time 0.004872/1.378, allocations: 3.718 MB / 0.8063 GB, free: 72.61 MB / 0.545 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003567/1.382, allocations: 0.6882 MB / 0.807 GB, free: 71.95 MB / 0.545 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02152/1.404, allocations: 16.42 MB / 0.823 GB, free: 55.5 MB / 0.545 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004888/1.408, allocations: 4.373 MB / 0.8273 GB, free: 51.09 MB / 0.545 GB Notification: Performance of simCode: alias equations: time 0.005188/1.414, allocations: 2.735 MB / 0.83 GB, free: 48.35 MB / 0.545 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0009996/1.415, allocations: 356.5 kB / 0.8303 GB, free: 48 MB / 0.545 GB Notification: Performance of SimCode: time 8.21e-07/1.415, allocations: 0 / 0.8303 GB, free: 48 MB / 0.545 GB Notification: Performance of Templates: time 0.3049/1.72, allocations: 76.34 MB / 0.9049 GB, free: 167.2 MB / 0.545 GB " [Timeout remaining time 658] make -j1 -f Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses.makefile [Timeout 660] (rm -f Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses.pipe ; mkfifo Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses.pipe ; head -c 1048576 < Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses.pipe >> ../files/Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses.sim & ./Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses -abortSlowSimulation -alarm=480 -s ida -emit_protected -lv LOG_STATS > Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses.pipe 2>&1) [Timeout 480] diffSimulationResults("Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/Modelica/Mechanics/MultiBody/Examples/Elementary/LineForceWithTwoMasses/LineForceWithTwoMasses.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Modelica_trunk_Modelica.Mechanics.MultiBody.Examples.Elementary.LineForceWithTwoMasses.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660] "" [Timeout remaining time 660] Reference file matches [Calling sys.exit(0), Time elapsed: 8.54521507001482]