Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Planar.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.Planar,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_Planar",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.MultiBody.Joints.Planar,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_Planar",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001378/0.001378, allocations: 103.9 kB / 17.63 MB, free: 5.523 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001428/0.001428, allocations: 210.4 kB / 18.58 MB, free: 4.578 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.59 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.294/0.294, allocations: 46.11 MB / 344.2 MB, free: 11.58 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.002481/0.002481, allocations: 80.83 kB / 417.8 MB, free: 19.62 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1366/0.1391, allocations: 62.46 MB / 480.2 MB, free: 5.148 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.Planar): time 0.01827/0.1574, allocations: 14.94 MB / 495.2 MB, free: 6.137 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01046/0.1679, allocations: 4.423 MB / 499.6 MB, free: 1.699 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002802/0.1708, allocations: 79.81 kB / 499.7 MB, free: 1.621 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.004942/0.1758, allocations: 2.215 MB / 0.4901 GB, free: 15.4 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.005301/0.1811, allocations: 1.988 MB / 0.492 GB, free: 13.41 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001581/0.1827, allocations: 0.6083 MB / 0.4926 GB, free: 12.8 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.006632/0.1894, allocations: 4.31 MB / 0.4968 GB, free: 8.48 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004485/0.1939, allocations: 3.154 MB / 0.4999 GB, free: 5.273 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002925/0.1968, allocations: 1.565 MB / 0.5015 GB, free: 3.703 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004288/0.2012, allocations: 2.212 MB / 0.5036 GB, free: 1.484 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001626/0.2028, allocations: 344 kB / 0.5039 GB, free: 1.148 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002755/0.2056, allocations: 1.034 MB / 0.505 GB, free: 116 kB / 382.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.2161/0.4217, allocations: 1.966 MB / 0.5069 GB, free: 16.33 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.003294/0.4251, allocations: 2.378 MB / 0.5092 GB, free: 15.55 MB / 382.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.009319/0.4344, allocations: 7.427 MB / 0.5164 GB, free: 14.55 MB / 382.1 MB
Notification: Performance of FrontEnd - DAE generated: time 6.292e-06/0.4345, allocations: 0 / 0.5164 GB, free: 14.55 MB / 382.1 MB
Notification: Performance of FrontEnd: time 1.783e-06/0.4345, allocations: 0 / 0.5164 GB, free: 14.55 MB / 382.1 MB
Notification: Performance of Transformations before backend: time 0.0002786/0.4347, allocations: 1.5 kB / 0.5165 GB, free: 14.55 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: 1828
 * Number of variables: 1828
Notification: Performance of Generate backend data structure: time 0.01355/0.4483, allocations: 5.068 MB / 0.5214 GB, free: 12.51 MB / 382.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.358e-05/0.4484, allocations: 9.812 kB / 0.5214 GB, free: 12.51 MB / 382.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.00214/0.4505, allocations: 0.8508 MB / 0.5222 GB, free: 12.43 MB / 382.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01171/0.4622, allocations: 3.202 MB / 0.5254 GB, free: 12.01 MB / 382.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006933/0.4692, allocations: 2.569 MB / 0.5279 GB, free: 10.91 MB / 382.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002559/0.4695, allocations: 254 kB / 0.5281 GB, free: 10.84 MB / 382.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00177/0.4713, allocations: 329.5 kB / 0.5284 GB, free: 10.77 MB / 382.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02068/0.492, allocations: 12.23 MB / 0.5404 GB, free: 4.191 MB / 382.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002133/0.4922, allocations: 36.19 kB / 0.5404 GB, free: 4.184 MB / 382.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00137/0.4936, allocations: 147.8 kB / 0.5406 GB, free: 4.125 MB / 382.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.004302/0.4979, allocations: 2.854 MB / 0.5433 GB, free: 3.023 MB / 382.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02322/0.5212, allocations: 11.13 MB / 0.5542 GB, free: 8.262 MB / 398.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.07212/0.5933, allocations: 40.7 MB / 0.594 GB, free: 15.14 MB / 446.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0107/0.6041, allocations: 4.697 MB / 0.5985 GB, free: 10.24 MB / 446.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00432/0.6084, allocations: 2.435 MB / 0.6009 GB, free: 7.809 MB / 446.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.001706/0.6102, allocations: 1.321 MB / 0.6022 GB, free: 6.273 MB / 446.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.876e-05/0.6103, allocations: 59 kB / 0.6023 GB, free: 6.211 MB / 446.1 MB
Notification: Performance of pre-optimization done (n=249): time 6.412e-06/0.6103, allocations: 0 / 0.6023 GB, free: 6.211 MB / 446.1 MB
Notification: Performance of matching and sorting (n=267): time 0.05491/0.6652, allocations: 18.68 MB / 0.6205 GB, free: 3.422 MB / 462.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.179e-05/0.6654, allocations: 80.5 kB / 0.6206 GB, free: 3.336 MB / 462.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007744/0.6731, allocations: 3.172 MB / 0.6237 GB, free: 156 kB / 462.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0006415/0.6738, allocations: 63.97 kB / 0.6237 GB, free: 88 kB / 462.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.002927/0.6767, allocations: 3.11 MB / 0.6268 GB, free: 12.97 MB / 478.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001633/0.6784, allocations: 0.9739 MB / 0.6277 GB, free: 12.01 MB / 478.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003561/0.682, allocations: 1.178 MB / 0.6289 GB, free: 10.82 MB / 478.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001358/0.6821, allocations: 309.1 kB / 0.6292 GB, free: 10.52 MB / 478.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004857/0.687, allocations: 2.456 MB / 0.6316 GB, free: 8.055 MB / 478.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.007931/0.6949, allocations: 5.727 MB / 0.6372 GB, free: 0.7812 MB / 478.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01291/0.7079, allocations: 8.965 MB / 0.6459 GB, free: 6.691 MB / 494.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001202/0.708, allocations: 35.75 kB / 0.6459 GB, free: 6.66 MB / 494.1 MB
Notification: Performance of matching and sorting (n=787) (initialization): time 0.01981/0.7279, allocations: 8.979 MB / 0.6547 GB, free: 14.21 MB / 0.4981 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001481/0.728, allocations: 52 kB / 0.6548 GB, free: 14.16 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002189/0.7283, allocations: 116 kB / 0.6549 GB, free: 14.05 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003508/0.7318, allocations: 1.051 MB / 0.6559 GB, free: 12.99 MB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005001/0.7368, allocations: 1.349 MB / 0.6572 GB, free: 11.64 MB / 0.4981 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008664/0.7455, allocations: 5.542 MB / 0.6626 GB, free: 5.973 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004516/0.7501, allocations: 318.3 kB / 0.6629 GB, free: 5.664 MB / 0.4981 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001396/0.7515, allocations: 359.9 kB / 0.6633 GB, free: 5.312 MB / 0.4981 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 517
 * Number of states: 0 ()
 * Number of discrete variables: 46 (axis1.arrowLine.twoHeadedArrow,axis1.headAtOrigin,axis2.arrowLine.twoHeadedArrow,axis2.headAtOrigin,axis1.color[3],axis1.color[2],axis1.color[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],planar.cylinderColor[3],planar.cylinderColor[2],planar.cylinderColor[1],planar.boxColor[3],planar.boxColor[2],planar.boxColor[1],planar.revolute.cylinderColor[3],planar.revolute.cylinderColor[2],planar.revolute.cylinderColor[1],planar.prismatic_y.boxColor[3],planar.prismatic_y.boxColor[2],planar.prismatic_y.boxColor[1],planar.prismatic_x.boxColor[3],planar.prismatic_x.boxColor[2],planar.prismatic_x.boxColor[1],axis2.color[3],axis2.color[2],axis2.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 (725):
 * Single equations (assignments): 718
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(4,11,87.5%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.00649/0.758, allocations: 2.403 MB / 0.6656 GB, free: 2.898 MB / 0.4981 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0009766/0.759, allocations: 308 kB / 0.6659 GB, free: 2.594 MB / 0.4981 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01187/0.7709, allocations: 5.367 MB / 0.6712 GB, free: 13.17 MB / 0.5137 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.026e-05/0.771, allocations: 47.98 kB / 0.6712 GB, free: 13.12 MB / 0.5137 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.586e-05/0.771, allocations: 4 kB / 0.6712 GB, free: 13.12 MB / 0.5137 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.31e-05/0.7711, allocations: 11.95 kB / 0.6712 GB, free: 13.11 MB / 0.5137 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0302/0.8013, allocations: 13.07 MB / 0.684 GB, free: 15.84 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.95e-05/0.8014, allocations: 12 kB / 0.684 GB, free: 15.83 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0021/0.8035, allocations: 423.3 kB / 0.6844 GB, free: 15.41 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003049/0.8065, allocations: 0.8873 MB / 0.6853 GB, free: 14.52 MB / 0.5294 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0005069/0.8071, allocations: 56 kB / 0.6853 GB, free: 14.47 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007136/0.8142, allocations: 4.842 MB / 0.6901 GB, free: 9.492 MB / 0.5294 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.692e-05/0.8142, allocations: 23.81 kB / 0.6901 GB, free: 9.469 MB / 0.5294 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01461/0.8289, allocations: 8.018 MB / 0.6979 GB, free: 1.234 MB / 0.5294 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001112/0.83, allocations: 361 kB / 0.6982 GB, free: 0.8594 MB / 0.5294 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000978/0.831, allocations: 60.03 kB / 0.6983 GB, free: 0.8008 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002023/0.833, allocations: 151.7 kB / 0.6985 GB, free: 0.6523 MB / 0.5294 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005809/0.8336, allocations: 164.8 kB / 0.6986 GB, free: 0.4922 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003153/0.834, allocations: 75.98 kB / 0.6987 GB, free: 428 kB / 0.5294 GB
Notification: Performance of sorting global known variables: time 0.004564/0.8385, allocations: 1.961 MB / 0.7006 GB, free: 14.46 MB / 0.545 GB
Notification: Performance of sort global known variables: time 8.32e-07/0.8386, allocations: 4 kB / 0.7006 GB, free: 14.46 MB / 0.545 GB
Notification: Performance of remove unused functions: time 0.007183/0.8458, allocations: 1.062 MB / 0.7016 GB, free: 13.39 MB / 0.545 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 49
 * Number of states: 6 (planar.s_x,planar.s_y,planar.phi,planar.v_x,planar.v_y,planar.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 (208):
 * Single equations (assignments): 201
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(3,9,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.0162/0.862, allocations: 8.686 MB / 0.7101 GB, free: 4.484 MB / 0.545 GB
Notification: Performance of simCode: created initialization part: time 0.2302/1.092, allocations: 9.629 MB / 0.7195 GB, free: 203.6 MB / 0.545 GB
Notification: Performance of simCode: created event and clocks part: time 1.007e-05/1.092, allocations: 1.25 kB / 0.7195 GB, free: 203.6 MB / 0.545 GB
Notification: Performance of simCode: created simulation system equations: time 0.003638/1.096, allocations: 2.255 MB / 0.7217 GB, free: 203.1 MB / 0.545 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002547/1.098, allocations: 463.4 kB / 0.7222 GB, free: 202.9 MB / 0.545 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.06907/1.168, allocations: 51.21 MB / 0.7722 GB, free: 157.5 MB / 0.545 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.005611/1.173, allocations: 3.706 MB / 0.7758 GB, free: 153.8 MB / 0.545 GB
Notification: Performance of simCode: alias equations: time 0.004673/1.178, allocations: 2.157 MB / 0.7779 GB, free: 151.6 MB / 0.545 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003093/1.181, allocations: 2.097 MB / 0.78 GB, free: 149.5 MB / 0.545 GB
Notification: Performance of SimCode: time 1.343e-06/1.181, allocations: 4 kB / 0.78 GB, free: 149.5 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1112/1.292, allocations: 69.88 MB / 0.8482 GB, free: 79.86 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate platform static: time 11.48/12.78, allocations: 14.66 kB / 0.8482 GB, free: 79.84 MB / 0.545 GB
(rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Planar.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Planar.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Planar.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Planar.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Planar_res.mat --tempDir=temp_ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_Planar_fmu --startTime=0 --stopTime=1.1 --timeout=50 --tolerance=1e-06 ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Joints_Planar.fmu > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Planar.pipe 2>&1)