Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Revolute2.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.Revolute2,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_Revolute2",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.MultiBody.Joints.Revolute2,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_Revolute2",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.0013/0.0013, allocations: 104.4 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.001384/0.001384, 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.45/1.45, 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.2328/0.2328, allocations: 46.11 MB / 344.2 MB, free: 11.55 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.002313/0.002313, allocations: 83.52 kB / 417.8 MB, free: 19.6 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1164/0.1187, allocations: 62.45 MB / 480.2 MB, free: 5.125 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.Revolute2): time 0.02121/0.14, allocations: 18.14 MB / 498.3 MB, free: 2.902 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01237/0.1524, allocations: 5.299 MB / 0.4918 GB, free: 13.59 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003423/0.1558, allocations: 103.8 kB / 0.4919 GB, free: 13.48 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.006835/0.1628, allocations: 3.052 MB / 0.4949 GB, free: 10.42 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.007389/0.1702, allocations: 2.547 MB / 0.4974 GB, free: 7.867 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002621/0.1728, allocations: 1.006 MB / 0.4984 GB, free: 6.859 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.2469/0.4198, allocations: 7.656 MB / 0.5059 GB, free: 13.39 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.006984/0.4268, allocations: 4.168 MB / 0.5099 GB, free: 13.03 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004454/0.4313, allocations: 2.243 MB / 0.5121 GB, free: 12.91 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.005843/0.4372, allocations: 3.235 MB / 0.5153 GB, free: 12.57 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.002257/0.4395, allocations: 455.8 kB / 0.5157 GB, free: 12.57 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00393/0.4434, allocations: 1.288 MB / 0.517 GB, free: 12.57 MB / 382.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.00393/0.4474, allocations: 2.797 MB / 0.5197 GB, free: 12.28 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.005143/0.4525, allocations: 3.224 MB / 0.5229 GB, free: 10.84 MB / 382.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01159/0.4642, allocations: 9.684 MB / 0.5323 GB, free: 6.594 MB / 382.1 MB
Notification: Performance of FrontEnd - DAE generated: time 8.376e-06/0.4642, allocations: 0 / 0.5323 GB, free: 6.594 MB / 382.1 MB
Notification: Performance of FrontEnd: time 3.346e-06/0.4642, allocations: 2.688 kB / 0.5323 GB, free: 6.594 MB / 382.1 MB
Notification: Performance of Transformations before backend: time 0.0003752/0.4646, allocations: 0 / 0.5323 GB, free: 6.594 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: 2169
 * Number of variables: 2169
Notification: Performance of Generate backend data structure: time 0.01875/0.4834, allocations: 7.319 MB / 0.5395 GB, free: 1.836 MB / 382.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.826e-05/0.4834, allocations: 13.83 kB / 0.5395 GB, free: 1.832 MB / 382.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.002879/0.4863, allocations: 1.005 MB / 0.5405 GB, free: 1.195 MB / 382.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02914/0.5155, allocations: 5.608 MB / 0.5459 GB, free: 14.09 MB / 398.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01239/0.5279, allocations: 4.816 MB / 0.5506 GB, free: 9.484 MB / 398.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000368/0.5283, allocations: 318.4 kB / 0.5509 GB, free: 9.227 MB / 398.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002314/0.5306, allocations: 426.4 kB / 0.5514 GB, free: 8.863 MB / 398.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03372/0.5644, allocations: 15.53 MB / 0.5665 GB, free: 8.852 MB / 414.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002057/0.5646, allocations: 60.89 kB / 0.5666 GB, free: 8.812 MB / 414.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0006661/0.5653, allocations: 191.9 kB / 0.5668 GB, free: 8.68 MB / 414.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.007222/0.5725, allocations: 3.388 MB / 0.5701 GB, free: 5.324 MB / 414.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03712/0.6097, allocations: 14.69 MB / 0.5844 GB, free: 6.805 MB / 430.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.09372/0.7035, allocations: 55.07 MB / 0.6382 GB, free: 15.3 MB / 494.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.02037/0.7239, allocations: 8.148 MB / 0.6462 GB, free: 6.93 MB / 494.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.008391/0.7323, allocations: 4.775 MB / 0.6508 GB, free: 2.145 MB / 494.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.002754/0.7351, allocations: 2.214 MB / 0.653 GB, free: 15.56 MB / 0.4981 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001746/0.7353, allocations: 65.08 kB / 0.653 GB, free: 15.49 MB / 0.4981 GB
Notification: Performance of pre-optimization done (n=367): time 8.947e-06/0.7353, allocations: 0 / 0.653 GB, free: 15.49 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=419): time 0.128/0.8633, allocations: 39.56 MB / 0.6917 GB, free: 7.988 MB / 0.5294 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001112/0.8635, allocations: 120 kB / 0.6918 GB, free: 7.852 MB / 0.5294 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008042/0.8715, allocations: 4.306 MB / 0.696 GB, free: 3.527 MB / 0.5294 GB
Notification: Performance of collectPreVariables (initialization): time 0.0009827/0.8725, allocations: 81.7 kB / 0.6961 GB, free: 3.441 MB / 0.5294 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003635/0.8762, allocations: 3.818 MB / 0.6998 GB, free: 15.61 MB / 0.545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002523/0.8787, allocations: 1.49 MB / 0.7013 GB, free: 14.14 MB / 0.545 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003236/0.882, allocations: 1.523 MB / 0.7027 GB, free: 12.61 MB / 0.545 GB
Notification: Performance of setup shared object (initialization): time 0.000145/0.8821, allocations: 305.1 kB / 0.703 GB, free: 12.31 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007246/0.8894, allocations: 3.95 MB / 0.7069 GB, free: 8.355 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.248/1.137, allocations: 7.688 MB / 0.7144 GB, free: 185.3 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01729/1.155, allocations: 12.65 MB / 0.7268 GB, free: 178.2 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001881/1.155, allocations: 36.91 kB / 0.7268 GB, free: 178.2 MB / 0.545 GB
Notification: Performance of matching and sorting (n=1008) (initialization): time 0.0306/1.186, allocations: 14.18 MB / 0.7406 GB, free: 173.8 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001655/1.186, allocations: 59.03 kB / 0.7407 GB, free: 173.8 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003312/1.186, allocations: 127.8 kB / 0.7408 GB, free: 173.8 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008849/1.195, allocations: 2.681 MB / 0.7434 GB, free: 173.4 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006687/1.202, allocations: 1.759 MB / 0.7452 GB, free: 173.2 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01738/1.219, allocations: 15.23 MB / 0.76 GB, free: 165.5 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008328/1.228, allocations: 495.3 kB / 0.7605 GB, free: 165.1 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001733/1.229, allocations: 427 kB / 0.7609 GB, free: 164.7 MB / 0.545 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 583
 * Number of states: 0 ()
 * Number of discrete variables: 50 (axis.arrowLine.twoHeadedArrow,axis.headAtOrigin,bodyCylinder.color[3],bodyCylinder.color[2],bodyCylinder.color[1],bodyCylinder.body.sphereColor[3],bodyCylinder.body.sphereColor[2],bodyCylinder.body.sphereColor[1],revolute3.cylinderColor[3],revolute3.cylinderColor[2],revolute3.cylinderColor[1],body2.sphereColor[3],body2.sphereColor[2],body2.sphereColor[1],revolute2.cylinderColor[3],revolute2.cylinderColor[2],revolute2.cylinderColor[1],body1.sphereColor[3],body1.sphereColor[2],body1.sphereColor[1],revolute1.cylinderColor[3],revolute1.cylinderColor[2],revolute1.cylinderColor[1],frame_a1.color_x[3],frame_a1.color_x[2],frame_a1.color_x[1],frame_a.color_x[3],frame_a.color_x[2],frame_a.color_x[1],body.sphereColor[3],body.sphereColor[2],body.sphereColor[1],revolute.cylinderColor[3],revolute.cylinderColor[2],revolute.cylinderColor[1],axis.color[3],axis.color[2],axis.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 (911):
 * Single equations (assignments): 903
 * Array equations: 6
 * 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
   {(6,32,69.4%), (1,12,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.005542/1.235, allocations: 2.869 MB / 0.7637 GB, free: 162.3 MB / 0.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0009739/1.236, allocations: 462.4 kB / 0.7641 GB, free: 162.1 MB / 0.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01636/1.252, allocations: 10.56 MB / 0.7745 GB, free: 153 MB / 0.545 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.006e-05/1.252, allocations: 75.45 kB / 0.7745 GB, free: 152.9 MB / 0.545 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.017e-05/1.252, allocations: 11.83 kB / 0.7745 GB, free: 152.9 MB / 0.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.894e-05/1.252, allocations: 19.92 kB / 0.7746 GB, free: 152.9 MB / 0.545 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.03451/1.287, allocations: 21.32 MB / 0.7954 GB, free: 131.5 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.995e-05/1.287, allocations: 12.94 kB / 0.7954 GB, free: 131.5 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003424/1.291, allocations: 0.6864 MB / 0.7961 GB, free: 130.8 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.006618/1.297, allocations: 2.494 MB / 0.7985 GB, free: 128.3 MB / 0.545 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0009876/1.298, allocations: 80.97 kB / 0.7986 GB, free: 128.2 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01492/1.313, allocations: 13.83 MB / 0.8121 GB, free: 114.2 MB / 0.545 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.003e-05/1.313, allocations: 16.81 kB / 0.8121 GB, free: 114.2 MB / 0.545 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02201/1.335, allocations: 15.11 MB / 0.8269 GB, free: 98.81 MB / 0.545 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001356/1.337, allocations: 498.7 kB / 0.8273 GB, free: 98.3 MB / 0.545 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001523/1.338, allocations: 79.98 kB / 0.8274 GB, free: 98.22 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003257/1.341, allocations: 308.5 kB / 0.8277 GB, free: 97.92 MB / 0.545 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008773/1.342, allocations: 258 kB / 0.8279 GB, free: 97.67 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.00029/1.343, allocations: 113.4 kB / 0.8281 GB, free: 97.56 MB / 0.545 GB
Notification: Performance of sorting global known variables: time 0.004416/1.347, allocations: 2.71 MB / 0.8307 GB, free: 94.85 MB / 0.545 GB
Notification: Performance of sort global known variables: time 4.11e-07/1.347, allocations: 0 / 0.8307 GB, free: 94.85 MB / 0.545 GB
Notification: Performance of remove unused functions: time 0.009636/1.357, allocations: 1.617 MB / 0.8323 GB, free: 93.24 MB / 0.545 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 49
 * Number of states: 7 (revolute.phi,revolute.w,constantSpeed.phi,revolute2.phi,revolute2.w,revolute3.phi,revolute3.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 (334):
 * Single equations (assignments): 326
 * Array equations: 6
 * 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,9,100.0%), (6,29,69.4%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.02284/1.38, allocations: 15.81 MB / 0.8477 GB, free: 77.16 MB / 0.545 GB
Notification: Performance of simCode: created initialization part: time 0.02918/1.409, allocations: 19.72 MB / 0.867 GB, free: 57.44 MB / 0.545 GB
Notification: Performance of simCode: created event and clocks part: time 1.696e-05/1.409, allocations: 4.125 kB / 0.867 GB, free: 57.43 MB / 0.545 GB
Notification: Performance of simCode: created simulation system equations: time 0.00637/1.415, allocations: 4.306 MB / 0.8712 GB, free: 53.1 MB / 0.545 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005349/1.421, allocations: 0.7451 MB / 0.8719 GB, free: 52.37 MB / 0.545 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3773/1.798, allocations: 79.81 MB / 0.9499 GB, free: 162.6 MB / 0.545 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.005935/1.804, allocations: 4.542 MB / 0.9543 GB, free: 161 MB / 0.545 GB
Notification: Performance of simCode: alias equations: time 0.006395/1.81, allocations: 2.723 MB / 0.957 GB, free: 160.9 MB / 0.545 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.006643/1.817, allocations: 2.821 MB / 0.9597 GB, free: 158.6 MB / 0.545 GB
Notification: Performance of SimCode: time 2.785e-06/1.817, allocations: 0 / 0.9597 GB, free: 158.6 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.167/1.984, allocations: 117.1 MB / 1.074 GB, free: 48.03 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate platform static: time 12.74/14.72, allocations: 12 kB / 1.074 GB, free: 48.02 MB / 0.545 GB
(rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Revolute2.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Revolute2.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Revolute2.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Revolute2.sim & python3 -m fmpy simulate  --output-file ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Revolute2_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_Revolute2.fmu > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Revolute2.pipe 2>&1)