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.001722/0.001722, allocations: 103.7 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.002102/0.002102, allocations: 212.6 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.47/1.47, 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.2431/0.2431, allocations: 46.12 MB / 344.2 MB, free: 11.57 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.00226/0.00226, allocations: 86 kB / 417.8 MB, free: 19.61 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1318/0.1341, allocations: 62.45 MB / 480.2 MB, free: 5.133 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.Planar): time 0.02555/0.1597, allocations: 14.94 MB / 495.2 MB, free: 6.117 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01335/0.1731, allocations: 4.415 MB / 499.6 MB, free: 1.688 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002817/0.176, allocations: 87.81 kB / 499.7 MB, free: 1.602 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.004733/0.1807, allocations: 2.223 MB / 0.4901 GB, free: 15.37 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.005379/0.1861, allocations: 1.98 MB / 0.492 GB, free: 13.39 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001751/0.1879, allocations: 0.6044 MB / 0.4926 GB, free: 12.78 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.006899/0.1948, allocations: 4.308 MB / 0.4968 GB, free: 8.465 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.005116/0.2, allocations: 3.154 MB / 0.4999 GB, free: 5.258 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003474/0.2035, allocations: 1.569 MB / 0.5015 GB, free: 3.684 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004269/0.2078, allocations: 2.215 MB / 0.5036 GB, free: 1.461 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001464/0.2093, allocations: 340 kB / 0.5039 GB, free: 1.129 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003213/0.2125, allocations: 1.03 MB / 0.505 GB, free: 100 kB / 382.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.244/0.4566, allocations: 1.967 MB / 0.5069 GB, free: 16.36 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.003701/0.4603, allocations: 2.381 MB / 0.5092 GB, free: 15.58 MB / 382.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01259/0.4729, allocations: 7.428 MB / 0.5165 GB, free: 14.57 MB / 382.1 MB
Notification: Performance of FrontEnd - DAE generated: time 1.125e-05/0.473, allocations: 0 / 0.5165 GB, free: 14.57 MB / 382.1 MB
Notification: Performance of FrontEnd: time 3.256e-06/0.473, allocations: 0 / 0.5165 GB, free: 14.57 MB / 382.1 MB
Notification: Performance of Transformations before backend: time 0.0004637/0.4735, allocations: 0 / 0.5165 GB, free: 14.57 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.01673/0.4902, allocations: 5.066 MB / 0.5214 GB, free: 12.54 MB / 382.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.011e-05/0.4903, allocations: 10.09 kB / 0.5214 GB, free: 12.54 MB / 382.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.002638/0.4929, allocations: 0.8525 MB / 0.5222 GB, free: 12.46 MB / 382.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01152/0.5045, allocations: 3.201 MB / 0.5254 GB, free: 12.05 MB / 382.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006978/0.5115, allocations: 2.563 MB / 0.5279 GB, free: 10.94 MB / 382.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002335/0.5118, allocations: 246 kB / 0.5281 GB, free: 10.88 MB / 382.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001643/0.5134, allocations: 344 kB / 0.5284 GB, free: 10.8 MB / 382.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0232/0.5366, allocations: 12.22 MB / 0.5404 GB, free: 4.207 MB / 382.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001351/0.5368, allocations: 36.69 kB / 0.5404 GB, free: 4.199 MB / 382.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007036/0.5375, allocations: 156.3 kB / 0.5406 GB, free: 4.141 MB / 382.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.004464/0.542, allocations: 2.848 MB / 0.5433 GB, free: 3.039 MB / 382.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02537/0.5674, allocations: 11.12 MB / 0.5542 GB, free: 8.277 MB / 398.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.07502/0.6425, allocations: 40.71 MB / 0.594 GB, free: 15.14 MB / 446.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.01156/0.6541, allocations: 4.697 MB / 0.5985 GB, free: 10.23 MB / 446.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004854/0.659, allocations: 2.432 MB / 0.6009 GB, free: 7.805 MB / 446.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.001624/0.6607, allocations: 1.318 MB / 0.6022 GB, free: 6.273 MB / 446.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.733e-05/0.6608, allocations: 63.12 kB / 0.6023 GB, free: 6.211 MB / 446.1 MB
Notification: Performance of pre-optimization done (n=249): time 8.475e-06/0.6608, allocations: 0 / 0.6023 GB, free: 6.211 MB / 446.1 MB
Notification: Performance of matching and sorting (n=267): time 0.0574/0.7182, allocations: 18.68 MB / 0.6205 GB, free: 3.418 MB / 462.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.581e-05/0.7183, allocations: 77.41 kB / 0.6206 GB, free: 3.332 MB / 462.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007288/0.7256, allocations: 3.18 MB / 0.6237 GB, free: 144 kB / 462.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0006569/0.7263, allocations: 64.36 kB / 0.6237 GB, free: 76 kB / 462.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.003183/0.7295, allocations: 3.107 MB / 0.6268 GB, free: 12.96 MB / 478.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001918/0.7315, allocations: 0.9688 MB / 0.6277 GB, free: 12 MB / 478.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003506/0.735, allocations: 1.182 MB / 0.6289 GB, free: 10.81 MB / 478.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001443/0.7352, allocations: 309.1 kB / 0.6292 GB, free: 10.51 MB / 478.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004627/0.7398, allocations: 2.456 MB / 0.6316 GB, free: 8.047 MB / 478.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.008379/0.7482, allocations: 5.724 MB / 0.6372 GB, free: 0.7734 MB / 478.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01351/0.7618, allocations: 8.971 MB / 0.6459 GB, free: 6.684 MB / 494.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001093/0.7619, allocations: 36 kB / 0.646 GB, free: 6.648 MB / 494.1 MB
Notification: Performance of matching and sorting (n=787) (initialization): time 0.02041/0.7823, allocations: 8.977 MB / 0.6547 GB, free: 14.2 MB / 0.4981 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001345/0.7825, allocations: 58.66 kB / 0.6548 GB, free: 14.14 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002343/0.7828, allocations: 112 kB / 0.6549 GB, free: 14.04 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003477/0.7862, allocations: 1.051 MB / 0.6559 GB, free: 12.98 MB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005175/0.7914, allocations: 1.337 MB / 0.6572 GB, free: 11.64 MB / 0.4981 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008464/0.7999, allocations: 5.556 MB / 0.6626 GB, free: 5.957 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005082/0.8051, allocations: 311.9 kB / 0.6629 GB, free: 5.652 MB / 0.4981 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001418/0.8065, allocations: 346.7 kB / 0.6633 GB, free: 5.316 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.006762/0.8133, allocations: 2.413 MB / 0.6656 GB, free: 2.891 MB / 0.4981 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0009124/0.8142, allocations: 308 kB / 0.6659 GB, free: 2.586 MB / 0.4981 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01079/0.825, allocations: 5.37 MB / 0.6712 GB, free: 13.16 MB / 0.5137 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.072e-05/0.8251, allocations: 47.75 kB / 0.6712 GB, free: 13.11 MB / 0.5137 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.119e-05/0.8251, allocations: 4 kB / 0.6712 GB, free: 13.11 MB / 0.5137 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.796e-05/0.8252, allocations: 13.64 kB / 0.6712 GB, free: 13.1 MB / 0.5137 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02767/0.8529, allocations: 13.07 MB / 0.684 GB, free: 15.83 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.45e-05/0.8529, allocations: 8 kB / 0.684 GB, free: 15.82 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002028/0.855, allocations: 423.5 kB / 0.6844 GB, free: 15.41 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003009/0.858, allocations: 0.8941 MB / 0.6853 GB, free: 14.51 MB / 0.5294 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0003772/0.8584, allocations: 51.98 kB / 0.6853 GB, free: 14.46 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.006933/0.8653, allocations: 4.835 MB / 0.69 GB, free: 9.492 MB / 0.5294 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.774e-05/0.8654, allocations: 19.88 kB / 0.6901 GB, free: 9.473 MB / 0.5294 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01343/0.8788, allocations: 8.019 MB / 0.6979 GB, free: 1.238 MB / 0.5294 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008581/0.8797, allocations: 365 kB / 0.6982 GB, free: 0.8594 MB / 0.5294 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004922/0.8802, allocations: 60.03 kB / 0.6983 GB, free: 0.8008 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001385/0.8816, allocations: 159.3 kB / 0.6985 GB, free: 0.6484 MB / 0.5294 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003939/0.882, allocations: 161.6 kB / 0.6986 GB, free: 500 kB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001871/0.8822, allocations: 75.98 kB / 0.6987 GB, free: 424 kB / 0.5294 GB
Notification: Performance of sorting global known variables: time 0.003325/0.8855, allocations: 1.961 MB / 0.7006 GB, free: 14.46 MB / 0.545 GB
Notification: Performance of sort global known variables: time 3.01e-07/0.8855, allocations: 0 / 0.7006 GB, free: 14.46 MB / 0.545 GB
Notification: Performance of remove unused functions: time 0.005072/0.8906, allocations: 1.059 MB / 0.7016 GB, free: 13.4 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.01334/0.904, allocations: 8.69 MB / 0.7101 GB, free: 4.488 MB / 0.545 GB
Notification: Performance of simCode: created initialization part: time 0.2216/1.126, allocations: 9.633 MB / 0.7195 GB, free: 203.6 MB / 0.545 GB
Notification: Performance of simCode: created event and clocks part: time 1.476e-05/1.126, allocations: 1.375 kB / 0.7195 GB, free: 203.6 MB / 0.545 GB
Notification: Performance of simCode: created simulation system equations: time 0.00385/1.13, allocations: 2.254 MB / 0.7217 GB, free: 203 MB / 0.545 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002734/1.132, allocations: 456.3 kB / 0.7222 GB, free: 202.8 MB / 0.545 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.06021/1.193, allocations: 51.23 MB / 0.7722 GB, free: 157.5 MB / 0.545 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.005474/1.198, allocations: 3.7 MB / 0.7758 GB, free: 153.8 MB / 0.545 GB
Notification: Performance of simCode: alias equations: time 0.004692/1.203, allocations: 2.153 MB / 0.7779 GB, free: 151.6 MB / 0.545 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003067/1.206, allocations: 2.1 MB / 0.78 GB, free: 149.5 MB / 0.545 GB
Notification: Performance of SimCode: time 1.022e-06/1.206, allocations: 0 / 0.78 GB, free: 149.5 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1243/1.33, allocations: 69.89 MB / 0.8482 GB, free: 79.84 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate platform static: time 11.54/12.87, allocations: 11.94 kB / 0.8482 GB, free: 79.82 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 & python3 -m fmpy simulate  --output-file ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Planar_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_Planar.fmu > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Joints.Planar.pipe 2>&1)