Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.JointRRR.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo", uses=false)
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.Joints.JointRRR,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_JointRRR",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.MultiBody.Joints.JointRRR,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_JointRRR",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001307/0.001307, allocations: 104.1 kB / 17.63 MB, free: 5.344 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001397/0.001397, allocations: 214.4 kB / 18.59 MB, free: 4.402 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.48/1.48, allocations: 227.4 MB / 246.8 MB, free: 10.52 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo): time 0.2408/0.2408, allocations: 46.11 MB / 344.2 MB, free: 11.56 MB / 286.1 MB
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.002379/0.002379, allocations: 84.75 kB / 417.8 MB, free: 19.61 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1121/0.1145, allocations: 62.46 MB / 480.2 MB, free: 5.133 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.JointRRR): time 0.01482/0.1293, allocations: 12.4 MB / 492.6 MB, free: 8.68 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.007962/0.1373, allocations: 3.914 MB / 496.5 MB, free: 4.758 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001656/0.139, allocations: 63.94 kB / 496.6 MB, free: 4.695 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.007307/0.1464, allocations: 3.852 MB / 0.4887 GB, free: 0.832 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.002493/0.1489, allocations: 0.8474 MB / 0.4895 GB, free: 15.98 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002194/0.1511, allocations: 0.8772 MB / 0.4904 GB, free: 15.1 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.003232/0.1544, allocations: 2.288 MB / 0.4926 GB, free: 12.81 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.006518/0.1609, allocations: 5.008 MB / 0.4975 GB, free: 7.734 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.00229/0.1632, allocations: 1.473 MB / 0.499 GB, free: 6.258 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003112/0.1664, allocations: 1.96 MB / 0.5009 GB, free: 4.293 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001141/0.1675, allocations: 472 kB / 0.5013 GB, free: 3.832 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002655/0.1702, allocations: 1.186 MB / 0.5025 GB, free: 2.645 MB / 382.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.002169/0.1724, allocations: 1.789 MB / 0.5042 GB, free: 0.8516 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.1934/0.3658, allocations: 2.06 MB / 0.5062 GB, free: 17.93 MB / 382.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.009106/0.375, allocations: 7.041 MB / 0.5131 GB, free: 17.64 MB / 382.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.851e-06/0.375, allocations: 0 / 0.5131 GB, free: 17.64 MB / 382.1 MB
Notification: Performance of FrontEnd: time 1.443e-06/0.375, allocations: 0 / 0.5131 GB, free: 17.64 MB / 382.1 MB
Notification: Performance of Transformations before backend: time 0.0002039/0.3752, allocations: 0 / 0.5131 GB, free: 17.64 MB / 382.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1173
 * Number of variables: 1173
Notification: Performance of Generate backend data structure: time 0.01321/0.3884, allocations: 4.326 MB / 0.5173 GB, free: 16.08 MB / 382.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.308e-05/0.3885, allocations: 10.09 kB / 0.5173 GB, free: 16.08 MB / 382.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001308/0.3898, allocations: 0.5871 MB / 0.5179 GB, free: 16.02 MB / 382.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003273/0.3931, allocations: 0.6537 MB / 0.5186 GB, free: 15.8 MB / 382.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004878/0.398, allocations: 2.221 MB / 0.5207 GB, free: 15 MB / 382.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001987/0.3982, allocations: 234.2 kB / 0.5209 GB, free: 14.91 MB / 382.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001016/0.3992, allocations: 320.1 kB / 0.5213 GB, free: 14.82 MB / 382.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02054/0.4198, allocations: 9.438 MB / 0.5305 GB, free: 10.4 MB / 382.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 7.366e-05/0.4199, allocations: 14.75 kB / 0.5305 GB, free: 10.4 MB / 382.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004675/0.4204, allocations: 136 kB / 0.5306 GB, free: 10.32 MB / 382.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001762/0.4222, allocations: 1.182 MB / 0.5318 GB, free: 9.879 MB / 382.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01733/0.4395, allocations: 8.642 MB / 0.5402 GB, free: 5.664 MB / 382.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.04072/0.4803, allocations: 27.24 MB / 0.5668 GB, free: 11.21 MB / 414.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.01014/0.4904, allocations: 3.115 MB / 0.5699 GB, free: 8.086 MB / 414.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002531/0.493, allocations: 1.67 MB / 0.5715 GB, free: 6.418 MB / 414.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.01402/0.507, allocations: 9.057 MB / 0.5803 GB, free: 12.91 MB / 430.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.619e-05/0.5071, allocations: 47.55 kB / 0.5804 GB, free: 12.86 MB / 430.1 MB
Notification: Performance of pre-optimization done (n=93): time 4.318e-06/0.5071, allocations: 4 kB / 0.5804 GB, free: 12.85 MB / 430.1 MB
Notification: Performance of matching and sorting (n=110): time 0.02865/0.5358, allocations: 7.759 MB / 0.588 GB, free: 5.098 MB / 430.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.445e-05/0.5359, allocations: 64.41 kB / 0.588 GB, free: 5.02 MB / 430.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005133/0.5411, allocations: 2.599 MB / 0.5906 GB, free: 2.395 MB / 430.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0002856/0.5414, allocations: 47.97 kB / 0.5906 GB, free: 2.344 MB / 430.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001939/0.5434, allocations: 2.144 MB / 0.5927 GB, free: 200 kB / 430.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0006573/0.544, allocations: 433 kB / 0.5931 GB, free: 15.77 MB / 446.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001579/0.5456, allocations: 0.7773 MB / 0.5939 GB, free: 14.99 MB / 446.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001416/0.5458, allocations: 305.1 kB / 0.5942 GB, free: 14.69 MB / 446.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002586/0.5484, allocations: 1.432 MB / 0.5956 GB, free: 13.25 MB / 446.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004404/0.5528, allocations: 3.506 MB / 0.599 GB, free: 8.77 MB / 446.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007436/0.5602, allocations: 5.187 MB / 0.604 GB, free: 2.863 MB / 446.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.409e-05/0.5603, allocations: 28 kB / 0.6041 GB, free: 2.836 MB / 446.1 MB
Notification: Performance of matching and sorting (n=478) (initialization): time 0.009812/0.5702, allocations: 4.919 MB / 0.6089 GB, free: 14.34 MB / 462.1 MB
Notification: Performance of prepare postOptimizeDAE: time 9.855e-05/0.5703, allocations: 43.94 kB / 0.6089 GB, free: 14.3 MB / 462.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001301/0.5704, allocations: 72 kB / 0.609 GB, free: 14.23 MB / 462.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000127/0.5706, allocations: 96 kB / 0.6091 GB, free: 14.13 MB / 462.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003496/0.5741, allocations: 0.8857 MB / 0.6099 GB, free: 13.32 MB / 462.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001616/0.5743, allocations: 145.5 kB / 0.6101 GB, free: 13.21 MB / 462.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003032/0.5773, allocations: 215.6 kB / 0.6103 GB, free: 13 MB / 462.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0006755/0.578, allocations: 216 kB / 0.6105 GB, free: 12.79 MB / 462.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 331
 * Number of states: 0 ()
 * Number of discrete variables: 59 (n1_a1.arrowLine.twoHeadedArrow,n1_a1.headAtOrigin,prism.arrowLine.twoHeadedArrow,prism.headAtOrigin,rRod2.arrowLine.twoHeadedArrow,rRod2.headAtOrigin,rRod1.arrowLine.twoHeadedArrow,rRod1.headAtOrigin,n1_a.arrowLine.twoHeadedArrow,n1_a.headAtOrigin,n1_a1.color[3],n1_a1.color[2],n1_a1.color[1],prism.color[3],prism.color[2],prism.color[1],rRod2.color[3],rRod2.color[2],rRod2.color[1],rRod1.color[3],rRod1.color[2],rRod1.color[1],n1_a.color[3],n1_a.color[2],n1_a.color[1],jointRRR.rodColor[3],jointRRR.rodColor[2],jointRRR.rodColor[1],jointRRR.cylinderColor[3],jointRRR.cylinderColor[2],jointRRR.cylinderColor[1],jointRRR.jointUSR.revolute.positiveBranch,jointRRR.jointUSR.rod1Color[3],jointRRR.jointUSR.rod1Color[2],jointRRR.jointUSR.rod1Color[1],jointRRR.jointUSR.cylinderColor[3],jointRRR.jointUSR.cylinderColor[2],jointRRR.jointUSR.cylinderColor[1],jointRRR.jointUSR.sphereColor[3],jointRRR.jointUSR.sphereColor[2],jointRRR.jointUSR.sphereColor[1],jointRRR.jointUSR.revoluteColor[3],jointRRR.jointUSR.revoluteColor[2],jointRRR.jointUSR.revoluteColor[1],Fixed1.color[3],Fixed1.color[2],Fixed1.color[1],world.groundColor[3],world.groundColor[2],world.groundColor[1],world.gravitySphereColor[3],world.gravitySphereColor[2],world.gravitySphereColor[1],world.gravityArrowColor[3],world.gravityArrowColor[2],world.gravityArrowColor[1],world.axisColor_x[3],world.axisColor_x[2],world.axisColor_x[1])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (476):
 * Single equations (assignments): 475
 * Array equations: 1
 * 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.004065/0.5821, allocations: 1.589 MB / 0.612 GB, free: 11.26 MB / 462.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007383/0.5828, allocations: 217.2 kB / 0.6123 GB, free: 11.05 MB / 462.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00484/0.5877, allocations: 2.105 MB / 0.6143 GB, free: 8.934 MB / 462.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.711e-05/0.5878, allocations: 12 kB / 0.6143 GB, free: 8.922 MB / 462.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.116e-05/0.5878, allocations: 0 / 0.6143 GB, free: 8.922 MB / 462.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.579e-05/0.5878, allocations: 3.984 kB / 0.6143 GB, free: 8.918 MB / 462.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01463/0.6024, allocations: 6.086 MB / 0.6203 GB, free: 2.668 MB / 462.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.475e-05/0.6025, allocations: 12 kB / 0.6203 GB, free: 2.656 MB / 462.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001144/0.6037, allocations: 253.9 kB / 0.6205 GB, free: 2.426 MB / 462.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 3.786e-05/0.6037, allocations: 20 kB / 0.6205 GB, free: 2.406 MB / 462.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001622/0.6039, allocations: 44 kB / 0.6206 GB, free: 2.363 MB / 462.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 3.415e-05/0.604, allocations: 31.02 kB / 0.6206 GB, free: 2.34 MB / 462.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.821e-05/0.604, allocations: 23.06 kB / 0.6206 GB, free: 2.324 MB / 462.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003626/0.6076, allocations: 2.185 MB / 0.6228 GB, free: 15.95 MB / 478.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0009725/0.6086, allocations: 314 kB / 0.6231 GB, free: 15.62 MB / 478.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005238/0.6091, allocations: 43.98 kB / 0.6231 GB, free: 15.58 MB / 478.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001259/0.6104, allocations: 63.94 kB / 0.6232 GB, free: 15.52 MB / 478.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002329/0.6107, allocations: 124.4 kB / 0.6233 GB, free: 15.4 MB / 478.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001033/0.6108, allocations: 55.98 kB / 0.6233 GB, free: 15.34 MB / 478.1 MB
Notification: Performance of sorting global known variables: time 0.003531/0.6143, allocations: 1.664 MB / 0.625 GB, free: 13.67 MB / 478.1 MB
Notification: Performance of sort global known variables: time 2.71e-07/0.6143, allocations: 0 / 0.625 GB, free: 13.67 MB / 478.1 MB
Notification: Performance of remove unused functions: time 0.004017/0.6184, allocations: 0.6758 MB / 0.6256 GB, free: 12.99 MB / 478.1 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 60
 * 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 (136):
 * Single equations (assignments): 136
 * 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.004167/0.6225, allocations: 2.826 MB / 0.6284 GB, free: 9.957 MB / 478.1 MB
Notification: Performance of simCode: created initialization part: time 0.006515/0.6291, allocations: 3.478 MB / 0.6318 GB, free: 6.5 MB / 478.1 MB
Notification: Performance of simCode: created event and clocks part: time 1.213e-05/0.6291, allocations: 0 / 0.6318 GB, free: 6.5 MB / 478.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.001401/0.6305, allocations: 0.8076 MB / 0.6326 GB, free: 5.695 MB / 478.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002652/0.6332, allocations: 357.2 kB / 0.6329 GB, free: 5.355 MB / 478.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.06283/0.6961, allocations: 31.26 MB / 0.6634 GB, free: 1.965 MB / 0.4981 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004924/0.701, allocations: 2.671 MB / 0.6661 GB, free: 15.27 MB / 0.5137 GB
Notification: Performance of simCode: alias equations: time 0.003194/0.7042, allocations: 0.9462 MB / 0.667 GB, free: 14.32 MB / 0.5137 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002607/0.7069, allocations: 1.366 MB / 0.6683 GB, free: 12.95 MB / 0.5137 GB
Notification: Performance of SimCode: time 4.559e-06/0.7069, allocations: 0 / 0.6683 GB, free: 12.95 MB / 0.5137 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.3108/1.018, allocations: 50.86 MB / 0.718 GB, free: 198.1 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate platform static: time 10.08/11.1, allocations: 6.031 kB / 0.718 GB, free: 198.1 MB / 0.545 GB
(rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.JointRRR.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.JointRRR.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.JointRRR.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.JointRRR.sim & python3 -m fmpy simulate  --output-file ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.JointRRR_res.csv --start-time 0 --stop-time 1.1 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.00044 ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_JointRRR.fmu > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.JointRRR.pipe 2>&1)