Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.MultiBody.Joints.UniversalSpherical.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.000867/0.000867, allocations: 88.28 kB / 21.43 MB, free: 3.133 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.005083/0.005083, allocations: 160.1 kB / 24.7 MB, free: 9.418 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 0.923/0.923, allocations: 177 MB / 204.9 MB, free: 5.715 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2439/0.2439, allocations: 34.25 MB / 295.6 MB, free: 0.6641 MB / 266.7 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/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: translateModel(ModelicaTest.MultiBody.Joints.UniversalSpherical,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5019,variableFilter="time|bodyBox.body.Q.1.|bodyBox.body.Q.2.|bodyBox.body.Q.3.|bodyBox.body.Q.4.|bodyBox.body.w_a.1.|bodyBox.body.w_a.2.|bodyBox.body.w_a.3.|bodyBox.v_0.1.|bodyBox.v_0.2.|bodyBox.v_0.3.|bodyBox1.body.Q.1.|bodyBox1.body.Q.2.|bodyBox1.body.Q.3.|bodyBox1.body.Q.4.|bodyBox1.body.w_a.1.|bodyBox1.body.w_a.2.|bodyBox1.body.w_a.3.|bodyBox2.body.Q.1.|bodyBox2.body.Q.2.|bodyBox2.body.Q.3.|bodyBox2.body.Q.4.|bodyBox2.body.frame_a.r_0.1.|bodyBox2.body.frame_a.r_0.2.|bodyBox2.body.frame_a.r_0.3.|bodyBox2.body.w_a.1.|bodyBox2.body.w_a.2.|bodyBox2.body.w_a.3.|bodyBox2.v_0.1.|bodyBox2.v_0.2.|bodyBox2.v_0.3.|universal.phi_a|universal.phi_b|universal.w_a|universal.w_b|universalSpherical.rRod_0.1.|universalSpherical.rRod_0.2.|universalSpherical.rRod_0.3.",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.MultiBody.Joints.UniversalSpherical")
translateModel(ModelicaTest.MultiBody.Joints.UniversalSpherical,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5019,variableFilter="time|bodyBox.body.Q.1.|bodyBox.body.Q.2.|bodyBox.body.Q.3.|bodyBox.body.Q.4.|bodyBox.body.w_a.1.|bodyBox.body.w_a.2.|bodyBox.body.w_a.3.|bodyBox.v_0.1.|bodyBox.v_0.2.|bodyBox.v_0.3.|bodyBox1.body.Q.1.|bodyBox1.body.Q.2.|bodyBox1.body.Q.3.|bodyBox1.body.Q.4.|bodyBox1.body.w_a.1.|bodyBox1.body.w_a.2.|bodyBox1.body.w_a.3.|bodyBox2.body.Q.1.|bodyBox2.body.Q.2.|bodyBox2.body.Q.3.|bodyBox2.body.Q.4.|bodyBox2.body.frame_a.r_0.1.|bodyBox2.body.frame_a.r_0.2.|bodyBox2.body.frame_a.r_0.3.|bodyBox2.body.w_a.1.|bodyBox2.body.w_a.2.|bodyBox2.body.w_a.3.|bodyBox2.v_0.1.|bodyBox2.v_0.2.|bodyBox2.v_0.3.|universal.phi_a|universal.phi_b|universal.w_a|universal.w_b|universalSpherical.rRod_0.1.|universalSpherical.rRod_0.2.|universalSpherical.rRod_0.3.",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.MultiBody.Joints.UniversalSpherical") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.994e-06/1.994e-06, allocations: 0 / 443.4 MB, free: 1.02 MB / 410.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 3.286e-05/3.486e-05, allocations: 2.281 kB / 443.4 MB, free: 1.016 MB / 410.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.UniversalSpherical): time 0.2177/0.2177, allocations: 23.55 MB / 467 MB, free: 29.74 MB / 410.7 MB
Notification: Performance of NFInst.instExpressions: time 0.013/0.2307, allocations: 8.462 MB / 475.5 MB, free: 24.13 MB / 410.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00384/0.2346, allocations: 281.1 kB / 475.7 MB, free: 24.04 MB / 410.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.01008/0.2447, allocations: 14.21 MB / 489.9 MB, free: 17.96 MB / 410.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.006902/0.2516, allocations: 3.925 MB / 493.9 MB, free: 15.96 MB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.007222/0.2588, allocations: 5.455 MB / 499.3 MB, free: 13.5 MB / 410.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01594/0.2747, allocations: 13.41 MB / 0.5007 GB, free: 8.246 MB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01471/0.2894, allocations: 13.74 MB / 0.5141 GB, free: 13.25 MB / 426.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.01206/0.3015, allocations: 8.169 MB / 0.5221 GB, free: 5.066 MB / 426.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.008489/0.31, allocations: 7.218 MB / 0.5292 GB, free: 13.83 MB / 442.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.00295/0.3129, allocations: 1.461 MB / 0.5306 GB, free: 12.37 MB / 442.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003871/0.3168, allocations: 2.759 MB / 0.5333 GB, free: 9.605 MB / 442.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.004473/0.3213, allocations: 6.944 MB / 0.5401 GB, free: 2.645 MB / 442.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.005747/0.327, allocations: 4.547 MB / 0.5445 GB, free: 14.09 MB / 458.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01858/0.3456, allocations: 23.94 MB / 0.5679 GB, free: 6.078 MB / 474.7 MB
Notification: Performance of FrontEnd - DAE generated: time 7.353e-06/0.3456, allocations: 0 / 0.5679 GB, free: 6.078 MB / 474.7 MB
Notification: Performance of FrontEnd: time 2.835e-06/0.3456, allocations: 0 / 0.5679 GB, free: 6.078 MB / 474.7 MB
Notification: Performance of Transformations before backend: time 0.000808/0.3464, allocations: 0 / 0.5679 GB, free: 6.078 MB / 474.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 4313
 * Number of variables: 4313
Notification: Performance of Generate backend data structure: time 0.03021/0.3766, allocations: 15.39 MB / 0.5829 GB, free: 6.574 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.249e-05/0.3767, allocations: 8.031 kB / 0.5829 GB, free: 6.566 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01904/0.3957, allocations: 5.376 MB / 0.5882 GB, free: 1.176 MB / 490.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01516/0.4109, allocations: 8.223 MB / 0.5962 GB, free: 8.863 MB / 0.4948 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005008/0.4114, allocations: 0.8468 MB / 0.597 GB, free: 8.016 MB / 0.4948 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003859/0.4152, allocations: 1.403 MB / 0.5984 GB, free: 6.613 MB / 0.4948 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.04402/0.4593, allocations: 30.27 MB / 0.628 GB, free: 6.844 MB / 0.5261 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003705/0.4596, allocations: 103.2 kB / 0.6281 GB, free: 6.742 MB / 0.5261 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001933/0.4616, allocations: 0.5115 MB / 0.6286 GB, free: 6.23 MB / 0.5261 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.003537/0.4651, allocations: 3.985 MB / 0.6324 GB, free: 2.246 MB / 0.5261 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.3869/0.852, allocations: 25.52 MB / 0.6574 GB, free: 123.7 MB / 0.5262 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 preOpt removeSimpleEquations (simulation): time 0.09813/0.9501, allocations: 98.13 MB / 0.7532 GB, free: 53.45 MB / 0.5262 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01873/0.9689, allocations: 12.12 MB / 0.765 GB, free: 41.34 MB / 0.5262 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005655/0.9745, allocations: 6.825 MB / 0.7717 GB, free: 34.5 MB / 0.5262 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.02462/0.9991, allocations: 26.41 MB / 0.7975 GB, free: 8.461 MB / 0.5262 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.752e-05/0.9992, allocations: 85.25 kB / 0.7976 GB, free: 8.367 MB / 0.5262 GB
Notification: Performance of pre-optimization done (n=404): time 6.262e-06/0.9992, allocations: 0 / 0.7976 GB, free: 8.367 MB / 0.5262 GB
Notification: Performance of matching and sorting (n=538): time 0.4352/1.434, allocations: 129 MB / 0.9236 GB, free: 151 MB / 0.573 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.01674/1.451, allocations: 22.68 MB / 0.9457 GB, free: 131.2 MB / 0.573 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008927/1.46, allocations: 9.214 MB / 0.9547 GB, free: 122.4 MB / 0.573 GB
Notification: Performance of collectPreVariables (initialization): time 0.001702/1.462, allocations: 105.7 kB / 0.9548 GB, free: 122.3 MB / 0.573 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00289/1.465, allocations: 8.488 MB / 0.9631 GB, free: 114.4 MB / 0.573 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002459/1.467, allocations: 2.153 MB / 0.9652 GB, free: 112.2 MB / 0.573 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003212/1.47, allocations: 3.287 MB / 0.9684 GB, free: 108.9 MB / 0.573 GB
Notification: Performance of setup shared object (initialization): time 2.753e-05/1.47, allocations: 301.1 kB / 0.9687 GB, free: 108.6 MB / 0.573 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.008206/1.479, allocations: 9.842 MB / 0.9783 GB, free: 98.79 MB / 0.573 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01054/1.489, allocations: 18.78 MB / 0.9967 GB, free: 75.69 MB / 0.573 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02182/1.511, allocations: 29.6 MB / 1.026 GB, free: 41.75 MB / 0.573 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002139/1.511, allocations: 88 kB / 1.026 GB, free: 41.66 MB / 0.573 GB
Notification: Performance of matching and sorting (n=2049) (initialization): time 0.05129/1.562, allocations: 39.48 MB / 1.064 GB, free: 2.062 MB / 0.573 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001267/1.563, allocations: 137.4 kB / 1.064 GB, free: 1.93 MB / 0.573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.254/1.816, allocations: 26.9 MB / 1.091 GB, free: 141.7 MB / 0.573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03094/1.847, allocations: 13.88 MB / 1.104 GB, free: 139.8 MB / 0.573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00927/1.857, allocations: 3.83 MB / 1.108 GB, free: 139.7 MB / 0.573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04153/1.898, allocations: 59.4 MB / 1.166 GB, free: 103 MB / 0.573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01112/1.909, allocations: 1.868 MB / 1.168 GB, free: 101.2 MB / 0.573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001634/1.911, allocations: 0.9371 MB / 1.169 GB, free: 100.3 MB / 0.573 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1392
 * Number of states: 0 ()
 * Number of discrete variables: 82 (init2.arrow.arrow.twoHeadedArrow,init2.arrow.headAtOrigin,init.arrow.arrow.twoHeadedArrow,init.arrow.headAtOrigin,rs3.arrow.twoHeadedArrow,rs3.arrow.headAtOrigin,rs2.arrow.twoHeadedArrow,rs2.arrow.headAtOrigin,rs1.arrow.twoHeadedArrow,rs1.arrow.headAtOrigin,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.groundColor[3],world.groundColor[2],world.groundColor[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 (1911):
 * Single equations (assignments): 1884
 * Array equations: 13
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 8
 * Torn equation systems: 6
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 3 systems
   {(4,100.0%), (4,100.0%), (4,100.0%)}
 * Non-linear Jacobian (size): 5 systems
   {1, 1, 4, 4, 4}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 6 systems
   {(5,8,88.0%), (8,21,76.6%), (1,3,100.0%), (1,9,100.0%), (5,6,84.0%), (1,4,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.008103/1.919, allocations: 5.871 MB / 1.174 GB, free: 94.58 MB / 0.573 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001553/1.921, allocations: 0.8036 MB / 1.175 GB, free: 94.23 MB / 0.573 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0316/1.952, allocations: 28.59 MB / 1.203 GB, free: 65.7 MB / 0.573 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.03193/1.984, allocations: 27.02 MB / 1.229 GB, free: 38.66 MB / 0.573 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.763e-05/1.984, allocations: 24.88 kB / 1.229 GB, free: 38.64 MB / 0.573 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001013/1.984, allocations: 27.84 kB / 1.23 GB, free: 38.61 MB / 0.573 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.06334/2.048, allocations: 52.9 MB / 1.281 GB, free: 1.504 MB / 0.5887 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.655e-05/2.048, allocations: 3.984 kB / 1.281 GB, free: 1.5 MB / 0.5887 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003199/2.051, allocations: 1.057 MB / 1.282 GB, free: 452 kB / 0.5887 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.2337/2.285, allocations: 15.04 MB / 1.297 GB, free: 171.8 MB / 0.6043 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001423/2.286, allocations: 155.3 kB / 1.297 GB, free: 171.8 MB / 0.6043 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.05112/2.337, allocations: 65.97 MB / 1.361 GB, free: 143.5 MB / 0.6043 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 0.01564/2.353, allocations: 22.44 MB / 1.383 GB, free: 131.6 MB / 0.6043 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04323/2.396, allocations: 40.49 MB / 1.423 GB, free: 95.97 MB / 0.6043 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003196/2.399, allocations: 0.8843 MB / 1.424 GB, free: 95.55 MB / 0.6043 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003115/2.402, allocations: 120.8 kB / 1.424 GB, free: 95.43 MB / 0.6043 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00556/2.408, allocations: 0.9632 MB / 1.425 GB, free: 94.46 MB / 0.6043 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001537/2.409, allocations: 426.7 kB / 1.425 GB, free: 94.05 MB / 0.6043 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003835/2.41, allocations: 171 kB / 1.425 GB, free: 93.88 MB / 0.6043 GB
Notification: Performance of sorting global known variables: time 0.004927/2.415, allocations: 5.353 MB / 1.431 GB, free: 88.55 MB / 0.6043 GB
Notification: Performance of sort global known variables: time 3.51e-07/2.415, allocations: 3.938 kB / 1.431 GB, free: 88.54 MB / 0.6043 GB
Notification: Performance of remove unused functions: time 0.01511/2.43, allocations: 4.55 MB / 1.435 GB, free: 84 MB / 0.6043 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 (411):
 * Single equations (assignments): 396
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 5
 * Torn equation systems: 7
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 3 systems
   {(3,100.0%), (4,100.0%), (4,100.0%)}
 * Non-linear Jacobian (size): 2 systems
   {3, 8}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 6 systems
   {(1,6,100.0%), (5,6,92.0%), (1,4,100.0%), (5,8,88.0%), (8,21,76.6%), (7,12,93.9%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(7,12)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.00114/2.431, allocations: 287.6 kB / 1.435 GB, free: 83.73 MB / 0.6043 GB
Notification: Performance of simCode: created initialization part: time 0.02299/2.454, allocations: 23.19 MB / 1.458 GB, free: 60.49 MB / 0.6043 GB
Notification: Performance of simCode: created event and clocks part: time 8.346e-06/2.454, allocations: 0 / 1.458 GB, free: 60.49 MB / 0.6043 GB
Notification: Performance of simCode: created simulation system equations: time 0.01045/2.464, allocations: 10.64 MB / 1.468 GB, free: 49.78 MB / 0.6043 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005742/2.47, allocations: 1.283 MB / 1.47 GB, free: 48.55 MB / 0.6043 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03638/2.507, allocations: 35.35 MB / 1.504 GB, free: 13.12 MB / 0.6043 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.1946/2.701, allocations: 8.179 MB / 1.512 GB, free: 165.5 MB / 0.6043 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003496/2.705, allocations: 0.742 MB / 1.513 GB, free: 165.5 MB / 0.6043 GB
Notification: Performance of SimCode: time 1.723e-06/2.705, allocations: 0 / 1.513 GB, free: 165.5 MB / 0.6043 GB
Notification: Performance of Templates: time 1.083/3.788, allocations: 0.8783 GB / 2.391 GB, free: 27.48 MB / 0.6199 GB
"
[Timeout remaining time 656]
make -j1 -f ModelicaTest_trunk_ModelicaTest.MultiBody.Joints.UniversalSpherical.makefile [Timeout 660]
(rm -f ModelicaTest_trunk_ModelicaTest.MultiBody.Joints.UniversalSpherical.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.MultiBody.Joints.UniversalSpherical.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.MultiBody.Joints.UniversalSpherical.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.MultiBody.Joints.UniversalSpherical.sim & ./ModelicaTest_trunk_ModelicaTest.MultiBody.Joints.UniversalSpherical  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_trunk_ModelicaTest.MultiBody.Joints.UniversalSpherical.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 24.5200702175498]
Failed to read output from testmodel.py, exit status != 0:
['time', 'bodyBox.body.Q[1]', 'bodyBox.body.Q[2]', 'bodyBox.body.Q[3]', 'bodyBox.body.Q[4]', 'bodyBox.body.w_a[1]', 'bodyBox.body.w_a[2]', 'bodyBox.body.w_a[3]', 'bodyBox.v_0[1]', 'bodyBox.v_0[2]', 'bodyBox.v_0[3]', 'bodyBox1.body.Q[1]', 'bodyBox1.body.Q[2]', 'bodyBox1.body.Q[3]', 'bodyBox1.body.Q[4]', 'bodyBox1.body.w_a[1]', 'bodyBox1.body.w_a[2]', 'bodyBox1.body.w_a[3]', 'bodyBox2.body.Q[1]', 'bodyBox2.body.Q[2]', 'bodyBox2.body.Q[3]', 'bodyBox2.body.Q[4]', 'bodyBox2.body.frame_a.r_0[1]', 'bodyBox2.body.frame_a.r_0[2]', 'bodyBox2.body.frame_a.r_0[3]', 'bodyBox2.body.w_a[1]', 'bodyBox2.body.w_a[2]', 'bodyBox2.body.w_a[3]', 'bodyBox2.v_0[1]', 'bodyBox2.v_0[2]', 'bodyBox2.v_0[3]', 'universal.phi_a', 'universal.phi_b', 'universal.w_a', 'universal.w_b', 'universalSpherical.rRod_0[1]', 'universalSpherical.rRod_0[2]', 'universalSpherical.rRod_0[3]']
3.7945236610248685 3.799978763 3.452741967
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x77b30e5b9f40>