Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.MultiBody.Joints.UniversalSpherical.conf.json
Using package ModelicaTest with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo)
Using package ModelicaServices with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo)
Using package Modelica with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo)
Using package Complex with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo)
Running command: "" <> buildModelFMU(ModelicaTest.MultiBody.Joints.UniversalSpherical,fileNamePrefix="ModelicaTest_3_2_1_ModelicaTest_MultiBody_Joints_UniversalSpherical",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.009434/0.009438, allocations: 160.9 kB / 15.12 MB, free: 5.965 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo): time 1.803/1.803, allocations: 170.8 MB / 186.6 MB, free: 1.117 MB / 154.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.001769/0.001769, allocations: 102.8 kB / 226.2 MB, free: 10.09 MB / 186.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo): time 0.4733/0.4733, allocations: 38.05 MB / 303.7 MB, free: 42.48 MB / 250.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004792/0.0004795, allocations: 12 kB / 363 MB, free: 5.488 MB / 266.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1138/0.1143, allocations: 48.72 MB / 411.7 MB, free: 4.691 MB / 314.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.UniversalSpherical): time 0.4593/0.5737, allocations: 111.2 MB / 0.5106 GB, free: 10.02 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.07922/0.653, allocations: 23.39 MB / 0.5335 GB, free: 5.75 MB / 378.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02838/0.6814, allocations: 0.5416 MB / 0.534 GB, free: 5.207 MB / 378.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.02195/0.7034, allocations: 5.583 MB / 0.5395 GB, free: 15.6 MB / 394.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.0728/0.7762, allocations: 18.77 MB / 0.5578 GB, free: 12.75 MB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01925/0.7956, allocations: 2.107 MB / 0.5599 GB, free: 10.64 MB / 410.7 MB
Notification: Performance of NFFlatten.flatten: time 0.4695/1.265, allocations: 47.17 MB / 0.6059 GB, free: 28.08 MB / 426.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.04824/1.313, allocations: 22.64 MB / 0.628 GB, free: 26.25 MB / 426.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.008833/1.322, allocations: 3.581 MB / 0.6315 GB, free: 26.25 MB / 426.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.01345/1.336, allocations: 5.967 MB / 0.6374 GB, free: 24.01 MB / 426.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.003576/1.339, allocations: 492 kB / 0.6378 GB, free: 23.53 MB / 426.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.007527/1.347, allocations: 1.665 MB / 0.6394 GB, free: 22.12 MB / 426.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.008807/1.356, allocations: 5.554 MB / 0.6449 GB, free: 18.08 MB / 426.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.005643/1.362, allocations: 2.646 MB / 0.6475 GB, free: 17.24 MB / 426.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.027/1.389, allocations: 20.67 MB / 0.6676 GB, free: 15.33 MB / 442.7 MB
Notification: Performance of FrontEnd - DAE generated: time 9.698e-06/1.389, allocations: 0 / 0.6676 GB, free: 15.33 MB / 442.7 MB
Notification: Performance of FrontEnd: time 3.797e-06/1.389, allocations: 1.969 kB / 0.6676 GB, free: 15.33 MB / 442.7 MB
Notification: Performance of Transformations before backend: time 0.0009783/1.39, allocations: 3 kB / 0.6676 GB, free: 15.33 MB / 442.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 4696
 * Number of variables: 4696
Notification: Performance of Generate backend data structure: time 0.05981/1.45, allocations: 13.45 MB / 0.6808 GB, free: 3.043 MB / 442.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.35e-05/1.45, allocations: 8.031 kB / 0.6808 GB, free: 3.035 MB / 442.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0106/1.46, allocations: 2.564 MB / 0.6833 GB, free: 1.434 MB / 442.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.5306/1.991, allocations: 19.6 MB / 0.7024 GB, free: 14.44 MB / 474.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03733/2.028, allocations: 10.25 MB / 0.7124 GB, free: 7.473 MB / 474.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001347/2.03, allocations: 0.8941 MB / 0.7133 GB, free: 6.969 MB / 474.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.009373/2.039, allocations: 1.464 MB / 0.7147 GB, free: 5.984 MB / 474.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.1052/2.144, allocations: 32.42 MB / 0.7464 GB, free: 14.51 MB / 0.4948 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0007035/2.145, allocations: 106.2 kB / 0.7465 GB, free: 14.45 MB / 0.4948 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.005967/2.151, allocations: 0.5317 MB / 0.747 GB, free: 14.32 MB / 0.4948 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.01156/2.163, allocations: 4.494 MB / 0.7514 GB, free: 10.7 MB / 0.4948 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.09652/2.259, allocations: 27.18 MB / 0.778 GB, free: 2.676 MB / 0.5105 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.8286/3.088, allocations: 112.3 MB / 0.8877 GB, free: 116.2 MB / 0.5105 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.06201/3.15, allocations: 13.02 MB / 0.9004 GB, free: 109.7 MB / 0.5105 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0144/3.165, allocations: 7.082 MB / 0.9073 GB, free: 103.6 MB / 0.5105 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.07251/3.237, allocations: 30.9 MB / 0.9375 GB, free: 71.8 MB / 0.5105 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.749e-05/3.237, allocations: 77.5 kB / 0.9375 GB, free: 71.71 MB / 0.5105 GB
Notification: Performance of pre-optimization done (n=427): time 9.758e-06/3.237, allocations: 3.984 kB / 0.9375 GB, free: 71.71 MB / 0.5105 GB
Notification: Performance of matching and sorting (n=555): time 1.258/4.495, allocations: 118.7 MB / 1.053 GB, free: 178.5 MB / 0.5107 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.05222/4.547, allocations: 23.17 MB / 1.076 GB, free: 164.3 MB / 0.5107 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02021/4.567, allocations: 9.435 MB / 1.085 GB, free: 158.2 MB / 0.5107 GB
Notification: Performance of collectPreVariables (initialization): time 0.001792/4.569, allocations: 112.4 kB / 1.085 GB, free: 158.1 MB / 0.5107 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006824/4.576, allocations: 8.898 MB / 1.094 GB, free: 149.2 MB / 0.5107 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003885/4.58, allocations: 2.15 MB / 1.096 GB, free: 147.1 MB / 0.5107 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002277/4.582, allocations: 319.3 kB / 1.096 GB, free: 146.7 MB / 0.5107 GB
Notification: Performance of setup shared object (initialization): time 0.000913/4.583, allocations: 0.9838 MB / 1.097 GB, free: 145.8 MB / 0.5107 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02162/4.605, allocations: 9.487 MB / 1.107 GB, free: 136.3 MB / 0.5107 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02761/4.633, allocations: 18.72 MB / 1.125 GB, free: 113.3 MB / 0.5107 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02842/4.661, allocations: 12.95 MB / 1.138 GB, free: 100.3 MB / 0.5107 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002755/4.661, allocations: 92 kB / 1.138 GB, free: 100.2 MB / 0.5107 GB
Notification: Performance of matching and sorting (n=2084) (initialization): time 0.1171/4.778, allocations: 35.25 MB / 1.172 GB, free: 64.83 MB / 0.5107 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001989/4.779, allocations: 144 kB / 1.172 GB, free: 64.69 MB / 0.5107 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.08017/4.859, allocations: 22.22 MB / 1.194 GB, free: 42.31 MB / 0.5107 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.3829/5.242, allocations: 9.27 MB / 1.203 GB, free: 165.3 MB / 0.5107 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.026/5.268, allocations: 4.024 MB / 1.207 GB, free: 165.3 MB / 0.5107 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08511/5.353, allocations: 46.59 MB / 1.252 GB, free: 143.5 MB / 0.5107 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02804/5.381, allocations: 1.698 MB / 1.254 GB, free: 143.3 MB / 0.5107 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003864/5.385, allocations: 0.9792 MB / 1.255 GB, free: 143.1 MB / 0.5107 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1473
 * Number of states: 0 ()
 * Number of discrete variables: 69 (init2.arrowColor[3],init2.arrowColor[2],init2.arrowColor[1],init.arrowColor[3],init.arrowColor[2],init.arrowColor[1],universal.cylinderColor[3],universal.cylinderColor[2],universal.cylinderColor[1],universalSpherical1.cylinderColor[3],universalSpherical1.cylinderColor[2],universalSpherical1.cylinderColor[1],universalSpherical1.sphereColor[3],universalSpherical1.sphereColor[2],universalSpherical1.sphereColor[1],universalSpherical1.rodColor[3],universalSpherical1.rodColor[2],universalSpherical1.rodColor[1],universalSpherical.cylinderColor[3],universalSpherical.cylinderColor[2],universalSpherical.cylinderColor[1],universalSpherical.sphereColor[3],universalSpherical.sphereColor[2],universalSpherical.sphereColor[1],universalSpherical.rodColor[3],universalSpherical.rodColor[2],universalSpherical.rodColor[1],rs3.arrowColor[3],rs3.arrowColor[2],rs3.arrowColor[1],rs2.arrowColor[3],rs2.arrowColor[2],rs2.arrowColor[1],bodyBox2.color[3],bodyBox2.color[2],bodyBox2.color[1],bodyBox2.body.sphereColor[3],bodyBox2.body.sphereColor[2],bodyBox2.body.sphereColor[1],bodyBox1.color[3],bodyBox1.color[2],bodyBox1.color[1],bodyBox1.body.sphereColor[3],bodyBox1.body.sphereColor[2],bodyBox1.body.sphereColor[1],spherical1.sphereColor[3],spherical1.sphereColor[2],spherical1.sphereColor[1],bodyBox.color[3],bodyBox.color[2],bodyBox.color[1],bodyBox.body.sphereColor[3],bodyBox.body.sphereColor[2],bodyBox.body.sphereColor[1],rs1.arrowColor[3],rs1.arrowColor[2],rs1.arrowColor[1],fixedTranslation.color[3],fixedTranslation.color[2],fixedTranslation.color[1],world.gravityArrowColor[3],world.gravityArrowColor[2],world.gravityArrowColor[1],world.axisColor_x[3],world.axisColor_x[2],world.axisColor_x[1],world.gravitySphereColor[3],world.gravitySphereColor[2],world.gravitySphereColor[1])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1958):
 * Single equations (assignments): 1931
 * Array equations: 13
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 8
 * Torn equation systems: 6
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 3 {(4,100.0%),(4,100.0%),(4,100.0%)}
 * Non-linear Jacobian: 5 {1,1,1,1,1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 6 {(4,93.8%) 8,(8,76.6%) 20,(1,100.0%) 3,(1,100.0%) 9,(4,87.5%) 6,(1,100.0%) 4}
 * Non-linear torn systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.01717/5.402, allocations: 6.265 MB / 1.261 GB, free: 140.2 MB / 0.5107 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003238/5.405, allocations: 0.8686 MB / 1.262 GB, free: 140.2 MB / 0.5107 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1192/5.525, allocations: 28.05 MB / 1.289 GB, free: 125.2 MB / 0.5107 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.1085/5.633, allocations: 26.21 MB / 1.315 GB, free: 99.05 MB / 0.5107 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 9.781e-05/5.633, allocations: 20.19 kB / 1.315 GB, free: 99.03 MB / 0.5107 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001501/5.634, allocations: 31.16 kB / 1.315 GB, free: 99 MB / 0.5107 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1954/5.829, allocations: 59.52 MB / 1.373 GB, free: 39.2 MB / 0.5107 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001216/5.829, allocations: 0 / 1.373 GB, free: 39.2 MB / 0.5107 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01106/5.84, allocations: 1.151 MB / 1.374 GB, free: 38.05 MB / 0.5107 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.4274/6.268, allocations: 14.26 MB / 1.388 GB, free: 160 MB / 0.5107 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001769/6.27, allocations: 169.6 kB / 1.388 GB, free: 160 MB / 0.5107 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.1288/6.398, allocations: 60.1 MB / 1.447 GB, free: 136.5 MB / 0.5107 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 0.05373/6.452, allocations: 22.91 MB / 1.469 GB, free: 124.2 MB / 0.5107 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1325/6.585, allocations: 39.55 MB / 1.508 GB, free: 86.26 MB / 0.5107 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01021/6.595, allocations: 2.497 MB / 1.511 GB, free: 84.22 MB / 0.5107 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003399/6.598, allocations: 124 kB / 1.511 GB, free: 84.1 MB / 0.5107 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01431/6.613, allocations: 0.863 MB / 1.512 GB, free: 83.24 MB / 0.5107 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002938/6.616, allocations: 416.5 kB / 1.512 GB, free: 82.83 MB / 0.5107 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001054/6.617, allocations: 183.4 kB / 1.512 GB, free: 82.66 MB / 0.5107 GB
Notification: Performance of sorting global known variables: time 0.01447/6.631, allocations: 5.826 MB / 1.518 GB, free: 76.88 MB / 0.5107 GB
Notification: Performance of sort global known variables: time 7.11e-07/6.631, allocations: 0 / 1.518 GB, free: 76.88 MB / 0.5107 GB
Notification: Performance of remove unused functions: time 0.02325/6.655, allocations: 4.282 MB / 1.522 GB, free: 72.6 MB / 0.5107 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 10
 * Number of states: 30 ($STATESET5.x[5],$STATESET5.x[4],$STATESET5.x[3],$STATESET5.x[2],$STATESET5.x[1],$STATESET4.x[2],$STATESET4.x[1],$STATESET3.x[6],$STATESET3.x[5],$STATESET3.x[4],$STATESET3.x[3],$STATESET3.x[2],$STATESET3.x[1],$STATESET2.x[5],$STATESET2.x[4],$STATESET2.x[3],$STATESET2.x[2],$STATESET2.x[1],$STATESET1.x[2],$STATESET1.x[1],bodyBox.body.w_a[1],bodyBox.body.w_a[2],bodyBox.body.w_a[3],bodyBox1.body.w_a[1],bodyBox1.body.w_a[2],bodyBox1.body.w_a[3],universal.phi_a,universal.phi_b,universal.w_a,universal.w_b)
 * 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 (436):
 * Single equations (assignments): 421
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 5
 * Torn equation systems: 7
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 3 {(3,100.0%),(4,100.0%),(4,100.0%)}
 * Non-linear Jacobian: 2 {3,8}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 6 {(1,100.0%) 6,(4,87.5%) 6,(1,100.0%) 4,(4,93.8%) 8,(8,76.6%) 20,(7,93.9%) 12}
 * Non-linear torn systems: 1 {7 12}
Notification: Performance of Backend phase and start with SimCode phase: time 0.1357/6.79, allocations: 40.33 MB / 1.561 GB, free: 32.31 MB / 0.5107 GB
Notification: Performance of simCode: created initialization part: time 0.3769/7.167, allocations: 23.28 MB / 1.584 GB, free: 166.4 MB / 0.5107 GB
Notification: Performance of simCode: created event and clocks part: time 8.316e-06/7.167, allocations: 0 / 1.584 GB, free: 166.4 MB / 0.5107 GB
Notification: Performance of simCode: created simulation system equations: time 0.03028/7.198, allocations: 11.37 MB / 1.595 GB, free: 163.1 MB / 0.5107 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01371/7.211, allocations: 1.36 MB / 1.597 GB, free: 162.6 MB / 0.5107 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3322/7.544, allocations: 143.9 MB / 1.737 GB, free: 38.8 MB / 0.5107 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01975/7.563, allocations: 9.462 MB / 1.746 GB, free: 29.29 MB / 0.5107 GB
Notification: Performance of simCode: alias equations: time 0.02221/7.586, allocations: 5.083 MB / 1.751 GB, free: 24.2 MB / 0.5107 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01556/7.601, allocations: 6.603 MB / 1.758 GB, free: 17.59 MB / 0.5107 GB
Notification: Performance of SimCode: time 1.953e-06/7.601, allocations: 0 / 1.758 GB, free: 17.59 MB / 0.5107 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.262/8.863, allocations: 286.4 MB / 2.037 GB, free: 101.4 MB / 0.5107 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0002548/8.864, allocations: 223.2 kB / 2.038 GB, free: 101.2 MB / 0.5107 GB
Notification: Performance of buildModelFMU: Generate platform static: time 13.42/22.29, allocations: 7.875 kB / 2.038 GB, free: 101.2 MB / 0.5107 GB