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.001749/0.001749, 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.002366/0.002366, 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.497/1.497, allocations: 227.4 MB / 246.8 MB, free: 10.48 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.2199/0.2199, allocations: 46.11 MB / 344.2 MB, free: 11.53 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.002264/0.002265, allocations: 81.3 kB / 417.8 MB, free: 19.58 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1367/0.1389, allocations: 62.45 MB / 480.2 MB, free: 5.109 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.Revolute2): time 0.02214/0.1611, allocations: 18.14 MB / 498.3 MB, free: 2.887 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01331/0.1745, allocations: 5.302 MB / 0.4918 GB, free: 13.57 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00363/0.1782, allocations: 103.8 kB / 0.4919 GB, free: 13.47 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.006883/0.1851, allocations: 3.052 MB / 0.4949 GB, free: 10.41 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.007654/0.1928, allocations: 2.541 MB / 0.4974 GB, free: 7.855 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002827/0.1957, allocations: 1.014 MB / 0.4984 GB, free: 6.84 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.2926/0.4883, allocations: 7.655 MB / 0.5059 GB, free: 14.02 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.008835/0.4972, allocations: 4.172 MB / 0.5099 GB, free: 13.65 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.006642/0.5039, allocations: 2.239 MB / 0.5121 GB, free: 13.53 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0084/0.5123, allocations: 3.235 MB / 0.5153 GB, free: 13.19 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.003352/0.5157, allocations: 452.1 kB / 0.5157 GB, free: 13.19 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.008125/0.5239, allocations: 1.292 MB / 0.517 GB, free: 13.19 MB / 382.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.007162/0.5311, allocations: 2.803 MB / 0.5197 GB, free: 12.9 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.009047/0.5402, allocations: 3.22 MB / 0.5229 GB, free: 11.12 MB / 382.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01817/0.5584, allocations: 9.684 MB / 0.5323 GB, free: 6.836 MB / 382.1 MB
Notification: Performance of FrontEnd - DAE generated: time 9.998e-06/0.5585, allocations: 0 / 0.5323 GB, free: 6.836 MB / 382.1 MB
Notification: Performance of FrontEnd: time 3.026e-06/0.5585, allocations: 0 / 0.5323 GB, free: 6.836 MB / 382.1 MB
Notification: Performance of Transformations before backend: time 0.000423/0.5589, allocations: 0 / 0.5323 GB, free: 6.836 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.02893/0.5879, allocations: 7.327 MB / 0.5395 GB, free: 2.074 MB / 382.1 MB
Notification: Performance of prepare preOptimizeDAE: time 6.244e-05/0.588, allocations: 10.97 kB / 0.5395 GB, free: 2.074 MB / 382.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.00363/0.5916, allocations: 1.005 MB / 0.5405 GB, free: 1.438 MB / 382.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04673/0.6384, allocations: 5.613 MB / 0.546 GB, free: 14.27 MB / 398.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01297/0.6514, allocations: 4.811 MB / 0.5506 GB, free: 9.672 MB / 398.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003582/0.6518, allocations: 316.5 kB / 0.551 GB, free: 9.414 MB / 398.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002065/0.6538, allocations: 438.9 kB / 0.5514 GB, free: 9.039 MB / 398.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03455/0.6884, allocations: 15.52 MB / 0.5665 GB, free: 9.035 MB / 414.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004425/0.6889, allocations: 60.61 kB / 0.5666 GB, free: 8.996 MB / 414.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001898/0.6908, allocations: 198.2 kB / 0.5668 GB, free: 8.855 MB / 414.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.007611/0.6984, allocations: 3.371 MB / 0.5701 GB, free: 5.516 MB / 414.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0345/0.733, allocations: 14.69 MB / 0.5844 GB, free: 6.992 MB / 430.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.1003/0.8333, allocations: 55.08 MB / 0.6382 GB, free: 15.5 MB / 494.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.02045/0.8538, allocations: 8.145 MB / 0.6462 GB, free: 7.125 MB / 494.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.007951/0.8618, allocations: 4.772 MB / 0.6508 GB, free: 2.344 MB / 494.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.002853/0.8647, allocations: 2.21 MB / 0.653 GB, free: 15.77 MB / 0.4981 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.74e-05/0.8648, allocations: 65.08 kB / 0.653 GB, free: 15.69 MB / 0.4981 GB
Notification: Performance of pre-optimization done (n=367): time 8.215e-06/0.8648, allocations: 0 / 0.653 GB, free: 15.69 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=419): time 0.1422/1.007, allocations: 39.57 MB / 0.6917 GB, free: 8.18 MB / 0.5294 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002421/1.007, allocations: 112 kB / 0.6918 GB, free: 8.051 MB / 0.5294 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0153/1.023, allocations: 4.31 MB / 0.696 GB, free: 3.723 MB / 0.5294 GB
Notification: Performance of collectPreVariables (initialization): time 0.001472/1.024, allocations: 81.7 kB / 0.6961 GB, free: 3.637 MB / 0.5294 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005791/1.03, allocations: 3.823 MB / 0.6998 GB, free: 15.81 MB / 0.545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003654/1.034, allocations: 1.492 MB / 0.7013 GB, free: 14.33 MB / 0.545 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00499/1.039, allocations: 1.514 MB / 0.7027 GB, free: 12.81 MB / 0.545 GB
Notification: Performance of setup shared object (initialization): time 0.0002118/1.039, allocations: 305.1 kB / 0.703 GB, free: 12.51 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01187/1.051, allocations: 3.942 MB / 0.7069 GB, free: 8.562 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.2713/1.322, allocations: 7.691 MB / 0.7144 GB, free: 185.8 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0173/1.34, allocations: 12.65 MB / 0.7268 GB, free: 178.5 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001409/1.34, allocations: 37.28 kB / 0.7268 GB, free: 178.5 MB / 0.545 GB
Notification: Performance of matching and sorting (n=1008) (initialization): time 0.03205/1.372, allocations: 14.17 MB / 0.7406 GB, free: 174 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001259/1.372, allocations: 56.78 kB / 0.7407 GB, free: 174 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002126/1.372, allocations: 127.3 kB / 0.7408 GB, free: 174 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007975/1.38, allocations: 2.689 MB / 0.7434 GB, free: 173.6 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006589/1.387, allocations: 1.766 MB / 0.7452 GB, free: 173.4 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01701/1.404, allocations: 15.22 MB / 0.76 GB, free: 165.7 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006514/1.41, allocations: 491.8 kB / 0.7605 GB, free: 165.3 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001808/1.412, allocations: 434.5 kB / 0.7609 GB, free: 164.9 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.007449/1.42, allocations: 2.87 MB / 0.7637 GB, free: 162.5 MB / 0.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001596/1.421, allocations: 458.4 kB / 0.7641 GB, free: 162.3 MB / 0.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02116/1.442, allocations: 10.56 MB / 0.7745 GB, free: 153.2 MB / 0.545 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.183e-05/1.443, allocations: 71.75 kB / 0.7745 GB, free: 153.1 MB / 0.545 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.325e-05/1.443, allocations: 8 kB / 0.7745 GB, free: 153.1 MB / 0.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 8.326e-05/1.443, allocations: 21.91 kB / 0.7746 GB, free: 153.1 MB / 0.545 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.04034/1.483, allocations: 21.34 MB / 0.7954 GB, free: 131.7 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.561e-05/1.483, allocations: 8 kB / 0.7954 GB, free: 131.7 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003221/1.486, allocations: 0.6864 MB / 0.7961 GB, free: 131 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.006568/1.493, allocations: 2.491 MB / 0.7985 GB, free: 128.5 MB / 0.545 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.000753/1.494, allocations: 81.09 kB / 0.7986 GB, free: 128.4 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01522/1.509, allocations: 13.83 MB / 0.8121 GB, free: 114.4 MB / 0.545 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.276e-05/1.509, allocations: 15.94 kB / 0.8121 GB, free: 114.4 MB / 0.545 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02533/1.534, allocations: 15.1 MB / 0.8268 GB, free: 99.02 MB / 0.545 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001386/1.536, allocations: 0.4952 MB / 0.8273 GB, free: 98.5 MB / 0.545 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001677/1.538, allocations: 77.7 kB / 0.8274 GB, free: 98.43 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003533/1.541, allocations: 313.3 kB / 0.8277 GB, free: 98.12 MB / 0.545 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001084/1.542, allocations: 258 kB / 0.828 GB, free: 97.87 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000571/1.543, allocations: 112 kB / 0.8281 GB, free: 97.76 MB / 0.545 GB
Notification: Performance of sorting global known variables: time 0.00462/1.547, allocations: 2.71 MB / 0.8307 GB, free: 95.05 MB / 0.545 GB
Notification: Performance of sort global known variables: time 4.31e-07/1.547, allocations: 1.422 kB / 0.8307 GB, free: 95.05 MB / 0.545 GB
Notification: Performance of remove unused functions: time 0.008227/1.556, allocations: 1.618 MB / 0.8323 GB, free: 93.43 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.02425/1.58, allocations: 15.81 MB / 0.8477 GB, free: 77.36 MB / 0.545 GB
Notification: Performance of simCode: created initialization part: time 0.02772/1.608, allocations: 19.72 MB / 0.867 GB, free: 57.63 MB / 0.545 GB
Notification: Performance of simCode: created event and clocks part: time 1.18e-05/1.608, allocations: 4 kB / 0.867 GB, free: 57.62 MB / 0.545 GB
Notification: Performance of simCode: created simulation system equations: time 0.005651/1.613, allocations: 4.306 MB / 0.8712 GB, free: 53.29 MB / 0.545 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005222/1.619, allocations: 0.7448 MB / 0.8719 GB, free: 52.56 MB / 0.545 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3771/1.996, allocations: 79.8 MB / 0.9499 GB, free: 163 MB / 0.545 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.007169/2.003, allocations: 4.544 MB / 0.9543 GB, free: 161.5 MB / 0.545 GB
Notification: Performance of simCode: alias equations: time 0.006989/2.01, allocations: 2.722 MB / 0.957 GB, free: 161.3 MB / 0.545 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.005033/2.015, allocations: 2.824 MB / 0.9597 GB, free: 159 MB / 0.545 GB
Notification: Performance of SimCode: time 2.144e-06/2.015, allocations: 4 kB / 0.9597 GB, free: 159 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1751/2.19, allocations: 117.1 MB / 1.074 GB, free: 48.42 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate platform static: time 12.74/14.93, allocations: 7.562 kB / 1.074 GB, free: 48.41 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 & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Revolute2_res.mat --tempDir=temp_ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_Revolute2_fmu --startTime=0 --stopTime=1.1 --timeout=50 --tolerance=1e-06 ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_Revolute2.fmu > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Revolute2.pipe 2>&1)