Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo", uses=false)
Using package ModelicaTest with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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: translateModel(ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|revolute1.phi|revolute1.w|revolute2.phi|revolute2.w",fileNamePrefix="ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2")
translateModel(ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|revolute1.phi|revolute1.w|revolute2.phi|revolute2.w",fileNamePrefix="ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001056/0.001056, allocations: 114.3 kB / 17.09 MB, free: 5.988 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001138/0.001138, allocations: 199.3 kB / 18.02 MB, free: 5.066 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.312/1.312, allocations: 205.1 MB / 223.9 MB, free: 12.25 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo): time 0.1979/0.1979, allocations: 43.52 MB / 314.8 MB, free: 460 kB / 254.1 MB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.00132/0.00132, allocations: 65.45 kB / 442.5 MB, free: 5.645 MB / 318.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1015/0.1029, allocations: 57.78 MB / 0.4886 GB, free: 11.79 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2): time 0.01643/0.1193, allocations: 17.37 MB / 0.5055 GB, free: 10.34 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01007/0.1294, allocations: 5.487 MB / 0.5109 GB, free: 4.84 MB / 398.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001957/0.1314, allocations: 115.6 kB / 0.511 GB, free: 4.727 MB / 398.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.007119/0.1386, allocations: 4.372 MB / 0.5153 GB, free: 348 kB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.00646/0.1451, allocations: 2.758 MB / 0.518 GB, free: 13.57 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002904/0.148, allocations: 1.47 MB / 0.5194 GB, free: 12.1 MB / 414.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01099/0.159, allocations: 8.125 MB / 0.5273 GB, free: 3.949 MB / 414.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.2301/0.3892, allocations: 5.38 MB / 0.5326 GB, free: 8.277 MB / 414.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005056/0.3943, allocations: 2.675 MB / 0.5352 GB, free: 8.152 MB / 414.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.006877/0.4012, allocations: 3.848 MB / 0.5389 GB, free: 7.781 MB / 414.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001916/0.4031, allocations: 0.5356 MB / 0.5395 GB, free: 7.781 MB / 414.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003782/0.4069, allocations: 1.624 MB / 0.5411 GB, free: 7.781 MB / 414.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.004491/0.4114, allocations: 3.397 MB / 0.5444 GB, free: 7.465 MB / 414.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.004995/0.4164, allocations: 3.657 MB / 0.5479 GB, free: 6.199 MB / 414.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01354/0.43, allocations: 11.21 MB / 0.5589 GB, free: 3.422 MB / 414.1 MB
Notification: Performance of FrontEnd - DAE generated: time 6.803e-06/0.43, allocations: 0 / 0.5589 GB, free: 3.422 MB / 414.1 MB
Notification: Performance of FrontEnd: time 2.074e-06/0.43, allocations: 1.25 kB / 0.5589 GB, free: 3.422 MB / 414.1 MB
Notification: Performance of Transformations before backend: time 0.0003766/0.4304, allocations: 0 / 0.5589 GB, free: 3.422 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: 2297
 * Number of variables: 2297
Notification: Performance of Generate backend data structure: time 0.01943/0.4499, allocations: 8.222 MB / 0.5669 GB, free: 14.12 MB / 430.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.376e-05/0.4499, allocations: 7.219 kB / 0.5669 GB, free: 14.12 MB / 430.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0261/0.476, allocations: 3.676 MB / 0.5705 GB, free: 12.43 MB / 430.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01257/0.4886, allocations: 5.59 MB / 0.576 GB, free: 9.367 MB / 430.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002098/0.4889, allocations: 372.2 kB / 0.5763 GB, free: 9.246 MB / 430.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00156/0.4904, allocations: 0.5153 MB / 0.5768 GB, free: 9.105 MB / 430.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03092/0.5214, allocations: 16.23 MB / 0.5927 GB, free: 9.484 MB / 446.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000229/0.5216, allocations: 81.23 kB / 0.5928 GB, free: 9.434 MB / 446.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007497/0.5224, allocations: 235.9 kB / 0.593 GB, free: 9.258 MB / 446.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.004566/0.527, allocations: 2.926 MB / 0.5959 GB, free: 6.371 MB / 446.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03031/0.5573, allocations: 13.68 MB / 0.6092 GB, free: 8.961 MB / 462.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.09332/0.6506, allocations: 64.48 MB / 0.6722 GB, free: 7.48 MB / 0.5137 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.024/0.6747, allocations: 7.842 MB / 0.6798 GB, free: 15.52 MB / 0.5294 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.007542/0.6823, allocations: 4.282 MB / 0.684 GB, free: 11.21 MB / 0.5294 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.03426/0.7166, allocations: 19.27 MB / 0.7028 GB, free: 7.43 MB / 0.545 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.183e-05/0.7167, allocations: 64.31 kB / 0.7029 GB, free: 7.363 MB / 0.545 GB
Notification: Performance of pre-optimization done (n=284): time 6.812e-06/0.7167, allocations: 0 / 0.7029 GB, free: 7.363 MB / 0.545 GB
Notification: Performance of matching and sorting (n=366): time 0.181/0.8978, allocations: 51.93 MB / 0.7536 GB, free: 3.391 MB / 0.5919 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000175/0.898, allocations: 276.7 kB / 0.7539 GB, free: 3.066 MB / 0.5919 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.2634/1.161, allocations: 6.083 MB / 0.7598 GB, free: 206.2 MB / 0.5919 GB
Notification: Performance of collectPreVariables (initialization): time 0.001155/1.163, allocations: 84.27 kB / 0.7599 GB, free: 206.2 MB / 0.5919 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003929/1.166, allocations: 4.679 MB / 0.7645 GB, free: 204.3 MB / 0.5919 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002149/1.169, allocations: 1.354 MB / 0.7658 GB, free: 203.6 MB / 0.5919 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003373/1.172, allocations: 1.908 MB / 0.7676 GB, free: 203.2 MB / 0.5919 GB
Notification: Performance of setup shared object (initialization): time 8.586e-05/1.172, allocations: 304.9 kB / 0.7679 GB, free: 202.9 MB / 0.5919 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007083/1.179, allocations: 4.197 MB / 0.772 GB, free: 201.5 MB / 0.5919 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00929/1.189, allocations: 9.426 MB / 0.7812 GB, free: 193.1 MB / 0.5919 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01464/1.203, allocations: 14.57 MB / 0.7955 GB, free: 182 MB / 0.5919 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002433/1.203, allocations: 53.94 kB / 0.7955 GB, free: 182 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=1250) (initialization): time 0.03257/1.236, allocations: 17.54 MB / 0.8127 GB, free: 174.4 MB / 0.5919 GB
Notification: Performance of prepare postOptimizeDAE: time 0.00028/1.236, allocations: 84 kB / 0.8127 GB, free: 174.3 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003584/1.237, allocations: 184 kB / 0.8129 GB, free: 174.1 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01317/1.25, allocations: 4.575 MB / 0.8174 GB, free: 171 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007005/1.257, allocations: 2.115 MB / 0.8194 GB, free: 169.1 MB / 0.5919 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0313/1.288, allocations: 25.44 MB / 0.8443 GB, free: 145.3 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00898/1.297, allocations: 0.5204 MB / 0.8448 GB, free: 144.8 MB / 0.5919 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002126/1.299, allocations: 0.5368 MB / 0.8453 GB, free: 144.3 MB / 0.5919 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 (1130):
 * Single equations (assignments): 1125
 * 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.008407/1.308, allocations: 3.128 MB / 0.8484 GB, free: 141.1 MB / 0.5919 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002026/1.31, allocations: 0.5708 MB / 0.8489 GB, free: 140.6 MB / 0.5919 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02151/1.331, allocations: 10.7 MB / 0.8594 GB, free: 129.8 MB / 0.5919 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.705e-05/1.331, allocations: 19.88 kB / 0.8594 GB, free: 129.8 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.825e-06/1.331, allocations: 4 kB / 0.8594 GB, free: 129.8 MB / 0.5919 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00331/1.335, allocations: 1.181 MB / 0.8606 GB, free: 128.6 MB / 0.5919 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001108/1.336, allocations: 57.12 kB / 0.8606 GB, free: 128.5 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002928/1.339, allocations: 231.7 kB / 0.8608 GB, free: 128.3 MB / 0.5919 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006853/1.34, allocations: 293.9 kB / 0.8611 GB, free: 128 MB / 0.5919 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01813/1.358, allocations: 10.31 MB / 0.8712 GB, free: 117.7 MB / 0.5919 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01245/1.37, allocations: 11.38 MB / 0.8823 GB, free: 106.3 MB / 0.5919 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003169/1.373, allocations: 3.215 MB / 0.8854 GB, free: 103 MB / 0.5919 GB
Notification: Performance of sorting global known variables: time 0.005773/1.379, allocations: 3.805 MB / 0.8892 GB, free: 99.25 MB / 0.5919 GB
Notification: Performance of Backend: time 5.31e-07/1.379, allocations: 0 / 0.8892 GB, free: 99.25 MB / 0.5919 GB
Notification: Performance of simCode: created initialization part: time 0.01467/1.394, allocations: 7.872 MB / 0.8968 GB, free: 91.41 MB / 0.5919 GB
Notification: Performance of SimCode: time 0.02377/1.418, allocations: 15.05 MB / 0.9115 GB, free: 76.36 MB / 0.5919 GB
Notification: Performance of Templates: time 0.3822/1.8, allocations: 95.09 MB / 1.004 GB, free: 183.6 MB / 0.5919 GB
make -j1 -f ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2.makefile
(rm -f ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2.pipe ; mkfifo ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2.pipe ; head -c 1048576 < ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2.pipe >> ../files/ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2.sim & ./ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2.pipe 2>&1)
diffSimulationResults("ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v3.2.3+build.4/ModelicaTest/MultiBody/Forces/ForceWithTwoMasses2/ForceWithTwoMasses2.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_3.2.3_ModelicaTest.MultiBody.Forces.ForceWithTwoMasses2.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches