Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.0.0_ModelicaTest.MultiBody.Joints.SphericalSpherical2.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001016/0.001016, allocations: 91.67 kB / 20.68 MB, free: 3.871 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.0008274/0.0008274, allocations: 166 kB / 23.95 MB, free: 0.5977 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.9114/0.9114, allocations: 177.1 MB / 204.3 MB, free: 5.711 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo): time 0.2498/0.2498, allocations: 32.79 MB / 293.5 MB, free: 1.223 MB / 266.7 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(ModelicaTest.MultiBody.Joints.SphericalSpherical2,fileNamePrefix="ModelicaTest_4_0_0_ModelicaTest_MultiBody_Joints_SphericalSpherical2",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.MultiBody.Joints.SphericalSpherical2,fileNamePrefix="ModelicaTest_4_0_0_ModelicaTest_MultiBody_Joints_SphericalSpherical2",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.262e-06/1.262e-06, allocations: 0 / 439.6 MB, free: 4.223 MB / 410.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.997e-05/2.123e-05, allocations: 2.281 kB / 439.6 MB, free: 4.219 MB / 410.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.SphericalSpherical2): time 0.193/0.193, allocations: 22.91 MB / 462.5 MB, free: 32.98 MB / 410.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01383/0.2068, allocations: 8.251 MB / 470.8 MB, free: 27.52 MB / 410.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005239/0.2121, allocations: 270.8 kB / 471 MB, free: 27.43 MB / 410.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.01242/0.2245, allocations: 13.84 MB / 484.9 MB, free: 21.52 MB / 410.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.008847/0.2334, allocations: 3.955 MB / 488.8 MB, free: 19.5 MB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.009076/0.2424, allocations: 5.31 MB / 494.1 MB, free: 17.09 MB / 410.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01794/0.2604, allocations: 14.8 MB / 0.497 GB, free: 11.78 MB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01607/0.2764, allocations: 13.91 MB / 0.5106 GB, free: 1.449 MB / 410.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.02232/0.2988, allocations: 8.2 MB / 0.5186 GB, free: 9.234 MB / 426.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.01187/0.3106, allocations: 7.506 MB / 0.5259 GB, free: 1.707 MB / 426.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.004796/0.3154, allocations: 1.422 MB / 0.5273 GB, free: 292 kB / 426.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.006883/0.3223, allocations: 2.576 MB / 0.5298 GB, free: 13.71 MB / 442.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.008397/0.3307, allocations: 7.011 MB / 0.5367 GB, free: 6.68 MB / 442.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.01047/0.3412, allocations: 4.715 MB / 0.5413 GB, free: 1.953 MB / 442.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.02681/0.368, allocations: 23.97 MB / 0.5647 GB, free: 9.918 MB / 474.7 MB
Notification: Performance of FrontEnd - DAE generated: time 9.308e-06/0.368, allocations: 3.984 kB / 0.5647 GB, free: 9.914 MB / 474.7 MB
Notification: Performance of FrontEnd: time 2.365e-06/0.368, allocations: 0 / 0.5647 GB, free: 9.914 MB / 474.7 MB
Notification: Performance of Transformations before backend: time 0.001171/0.3692, allocations: 0 / 0.5647 GB, free: 9.914 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: 4224
 * Number of variables: 4224
Notification: Performance of Generate backend data structure: time 0.03902/0.4082, allocations: 15.37 MB / 0.5797 GB, free: 10.44 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.154e-05/0.4082, allocations: 8.031 kB / 0.5797 GB, free: 10.43 MB / 490.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.006796/0.415, allocations: 2.341 MB / 0.582 GB, free: 8.074 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.118/0.533, allocations: 19.97 MB / 0.6015 GB, free: 4.074 MB / 0.4948 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01893/0.5519, allocations: 8.595 MB / 0.6099 GB, free: 11.39 MB / 0.5105 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008194/0.5528, allocations: 0.8389 MB / 0.6107 GB, free: 10.55 MB / 0.5105 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005749/0.5585, allocations: 1.475 MB / 0.6121 GB, free: 9.078 MB / 0.5105 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.4124/0.9709, allocations: 29.42 MB / 0.6409 GB, free: 127.8 MB / 0.5262 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0005585/0.9714, allocations: 113.8 kB / 0.641 GB, free: 127.8 MB / 0.5262 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003435/0.9749, allocations: 0.5032 MB / 0.6415 GB, free: 127.6 MB / 0.5262 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.003101/0.978, allocations: 3.728 MB / 0.6451 GB, free: 126.9 MB / 0.5262 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03759/1.016, allocations: 23.94 MB / 0.6685 GB, free: 119.6 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.09584/1.111, allocations: 98.42 MB / 0.7646 GB, free: 46.27 MB / 0.5262 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01856/1.13, allocations: 11.39 MB / 0.7757 GB, free: 34.9 MB / 0.5262 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004955/1.135, allocations: 5.504 MB / 0.7811 GB, free: 29.38 MB / 0.5262 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001675/1.137, allocations: 1.675 MB / 0.7828 GB, free: 27.72 MB / 0.5262 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.542e-05/1.137, allocations: 79.06 kB / 0.7828 GB, free: 27.64 MB / 0.5262 GB
Notification: Performance of pre-optimization done (n=390): time 7.154e-06/1.137, allocations: 4 kB / 0.7828 GB, free: 27.63 MB / 0.5262 GB
Notification: Performance of matching and sorting (n=522): time 0.4612/1.598, allocations: 124.2 MB / 0.9042 GB, free: 157.2 MB / 0.573 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0208/1.619, allocations: 24.42 MB / 0.928 GB, free: 143.2 MB / 0.573 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01195/1.631, allocations: 10.71 MB / 0.9385 GB, free: 139.4 MB / 0.573 GB
Notification: Performance of collectPreVariables (initialization): time 0.001447/1.632, allocations: 104.5 kB / 0.9386 GB, free: 139.3 MB / 0.573 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003825/1.636, allocations: 8.525 MB / 0.9469 GB, free: 132.4 MB / 0.573 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00275/1.639, allocations: 2.084 MB / 0.9489 GB, free: 130.6 MB / 0.573 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.004329/1.643, allocations: 3.138 MB / 0.952 GB, free: 128.9 MB / 0.573 GB
Notification: Performance of setup shared object (initialization): time 2.979e-05/1.643, allocations: 313 kB / 0.9523 GB, free: 128.6 MB / 0.573 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00891/1.652, allocations: 9.499 MB / 0.9616 GB, free: 122.2 MB / 0.573 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01464/1.667, allocations: 18.42 MB / 0.9796 GB, free: 99.41 MB / 0.573 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02319/1.69, allocations: 28.89 MB / 1.008 GB, free: 66.17 MB / 0.573 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0003684/1.69, allocations: 88 kB / 1.008 GB, free: 66.08 MB / 0.573 GB
Notification: Performance of matching and sorting (n=1977) (initialization): time 0.06152/1.752, allocations: 40.41 MB / 1.047 GB, free: 25.55 MB / 0.573 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001415/1.752, allocations: 136 kB / 1.047 GB, free: 25.41 MB / 0.573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.2653/2.017, allocations: 27.67 MB / 1.074 GB, free: 143.9 MB / 0.573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03574/2.053, allocations: 15.85 MB / 1.09 GB, free: 143.8 MB / 0.573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009013/2.062, allocations: 3.664 MB / 1.094 GB, free: 143.7 MB / 0.573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05502/2.117, allocations: 63.41 MB / 1.155 GB, free: 113.1 MB / 0.573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01381/2.131, allocations: 2.004 MB / 1.157 GB, free: 112.2 MB / 0.573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003452/2.134, allocations: 0.924 MB / 1.158 GB, free: 112 MB / 0.573 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1396
 * Number of states: 0 ()
 * Number of discrete variables: 88 (freeMotionScalarInit1.arrow.arrow.twoHeadedArrow,freeMotionScalarInit1.arrow.headAtOrigin,freeMotionScalarInit.arrow.arrow.twoHeadedArrow,freeMotionScalarInit.arrow.headAtOrigin,rs3.arrow.twoHeadedArrow,rs3.arrow.headAtOrigin,rs2.arrow.twoHeadedArrow,rs2.arrow.headAtOrigin,rs1.arrow.twoHeadedArrow,rs1.arrow.headAtOrigin,freeMotionScalarInit1.arrowColor[3],freeMotionScalarInit1.arrowColor[2],freeMotionScalarInit1.arrowColor[1],freeMotionScalarInit.arrowColor[3],freeMotionScalarInit.arrowColor[2],freeMotionScalarInit.arrowColor[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],sphericalSpherical1.massColor[3],sphericalSpherical1.massColor[2],sphericalSpherical1.massColor[1],sphericalSpherical1.sphereColor[3],sphericalSpherical1.sphereColor[2],sphericalSpherical1.sphereColor[1],sphericalSpherical1.rodColor[3],sphericalSpherical1.rodColor[2],sphericalSpherical1.rodColor[1],body.sphereColor[3],body.sphereColor[2],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],fixedTranslation1.color[3],fixedTranslation1.color[2],fixedTranslation1.color[1],fixedTranslation.color[3],fixedTranslation.color[2],fixedTranslation.color[1],spherical.sphereColor[3],spherical.sphereColor[2],spherical.sphereColor[1],sphericalSpherical.massColor[3],sphericalSpherical.massColor[2],sphericalSpherical.massColor[1],sphericalSpherical.sphereColor[3],sphericalSpherical.sphereColor[2],sphericalSpherical.sphereColor[1],sphericalSpherical.rodColor[3],sphericalSpherical.rodColor[2],sphericalSpherical.rodColor[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 (1801):
 * Single equations (assignments): 1772
 * Array equations: 15
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 10
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 4 systems
   {(4,100.0%), (4,100.0%), (4,100.0%), (4,100.0%)}
 * Non-linear Jacobian (size): 6 systems
   {1, 1, 4, 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): 4 systems
   {(8,32,82.8%), (1,3,100.0%), (4,20,93.8%), (7,23,63.3%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.01177/2.146, allocations: 5.778 MB / 1.164 GB, free: 108.8 MB / 0.573 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002703/2.149, allocations: 0.8891 MB / 1.165 GB, free: 108.8 MB / 0.573 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002946/2.151, allocations: 1.535 MB / 1.166 GB, free: 107.6 MB / 0.573 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.03543/2.187, allocations: 26.89 MB / 1.193 GB, free: 81.19 MB / 0.573 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.0001094/2.187, allocations: 27.97 kB / 1.193 GB, free: 81.16 MB / 0.573 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001092/2.187, allocations: 25.44 kB / 1.193 GB, free: 81.14 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.07364/2.261, allocations: 58.41 MB / 1.25 GB, free: 22.3 MB / 0.573 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.899e-05/2.261, allocations: 2.562 kB / 1.25 GB, free: 22.3 MB / 0.573 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003113/2.264, allocations: 0.9554 MB / 1.251 GB, free: 21.34 MB / 0.573 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.02752/2.291, allocations: 15.83 MB / 1.266 GB, free: 5.473 MB / 0.573 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001361/2.293, allocations: 167.8 kB / 1.266 GB, free: 5.309 MB / 0.573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.2863/2.579, allocations: 69.26 MB / 1.334 GB, free: 158.5 MB / 0.6043 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 0.02342/2.603, allocations: 24.21 MB / 1.357 GB, free: 145 MB / 0.6043 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04884/2.651, allocations: 39.6 MB / 1.396 GB, free: 125.9 MB / 0.6043 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003651/2.655, allocations: 1.042 MB / 1.397 GB, free: 125.3 MB / 0.6043 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003605/2.659, allocations: 120 kB / 1.397 GB, free: 125.2 MB / 0.6043 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.007372/2.666, allocations: 1.022 MB / 1.398 GB, free: 124.2 MB / 0.6043 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002428/2.668, allocations: 450.4 kB / 1.399 GB, free: 123.7 MB / 0.6043 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004878/2.669, allocations: 163.8 kB / 1.399 GB, free: 123.6 MB / 0.6043 GB
Notification: Performance of sorting global known variables: time 0.007861/2.677, allocations: 6.481 MB / 1.405 GB, free: 117.1 MB / 0.6043 GB
Notification: Performance of sort global known variables: time 2.71e-07/2.677, allocations: 0 / 1.405 GB, free: 117.1 MB / 0.6043 GB
Notification: Performance of remove unused functions: time 0.01512/2.692, allocations: 4.711 MB / 1.41 GB, free: 112.4 MB / 0.6043 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 16
 * Number of states: 32 ($STATESET6.x[2],$STATESET6.x[1],$STATESET5.x[5],$STATESET5.x[4],$STATESET5.x[3],$STATESET5.x[2],$STATESET5.x[1],$STATESET4.x[6],$STATESET4.x[5],$STATESET4.x[4],$STATESET4.x[3],$STATESET4.x[2],$STATESET4.x[1],$STATESET3.x[3],$STATESET3.x[2],$STATESET3.x[1],$STATESET2.x[2],$STATESET2.x[1],$STATESET1.x[5],$STATESET1.x[4],$STATESET1.x[3],$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],body.w_a[1],body.w_a[2],body.w_a[3])
 * 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 (360):
 * Single equations (assignments): 345
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * 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): 3 systems
   {3, 8, 4}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 5 systems
   {(4,17,93.8%), (3,3,100.0%), (8,29,82.8%), (7,12,93.9%), (7,20,63.3%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(7,12)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.04647/2.738, allocations: 40.39 MB / 1.449 GB, free: 72.37 MB / 0.6043 GB
Notification: Performance of simCode: created initialization part: time 0.02772/2.766, allocations: 22.63 MB / 1.471 GB, free: 49.71 MB / 0.6043 GB
Notification: Performance of simCode: created event and clocks part: time 8.506e-06/2.766, allocations: 0 / 1.471 GB, free: 49.71 MB / 0.6043 GB
Notification: Performance of simCode: created simulation system equations: time 0.01293/2.779, allocations: 10.63 MB / 1.482 GB, free: 38.98 MB / 0.6043 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.008862/2.788, allocations: 1.531 MB / 1.483 GB, free: 37.52 MB / 0.6043 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4662/3.254, allocations: 186.4 MB / 1.665 GB, free: 63.17 MB / 0.6043 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01612/3.27, allocations: 8.174 MB / 1.673 GB, free: 55.02 MB / 0.6043 GB
Notification: Performance of simCode: alias equations: time 0.009643/3.28, allocations: 4.85 MB / 1.678 GB, free: 50.34 MB / 0.6043 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.009372/3.289, allocations: 5.971 MB / 1.684 GB, free: 44.37 MB / 0.6043 GB
Notification: Performance of SimCode: time 2.204e-06/3.289, allocations: 4 kB / 1.684 GB, free: 44.37 MB / 0.6043 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.7285/4.018, allocations: 299.3 MB / 1.976 GB, free: 157.8 MB / 0.6199 GB
Notification: Performance of buildModelFMU: Generate platform static: time 22.13/26.15, allocations: 3.953 kB / 1.976 GB, free: 157.8 MB / 0.6199 GB
"
[Timeout remaining time 634]
(rm -f ModelicaTest_4.0.0_ModelicaTest.MultiBody.Joints.SphericalSpherical2.pipe ; mkfifo ModelicaTest_4.0.0_ModelicaTest.MultiBody.Joints.SphericalSpherical2.pipe ; head -c 1048576 < ModelicaTest_4.0.0_ModelicaTest.MultiBody.Joints.SphericalSpherical2.pipe >> ../files/ModelicaTest_4.0.0_ModelicaTest.MultiBody.Joints.SphericalSpherical2.sim & python3 -m fmpy simulate  --output-file ModelicaTest_4.0.0_ModelicaTest.MultiBody.Joints.SphericalSpherical2_res.csv --start-time 0 --stop-time 2 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.000397298 ModelicaTest_4_0_0_ModelicaTest_MultiBody_Joints_SphericalSpherical2.fmu > ModelicaTest_4.0.0_ModelicaTest.MultiBody.Joints.SphericalSpherical2.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 28.437227028422058]
Failed to read output from testmodel.py, exit status != 0:
['time', 'body.Q[1]', 'body.Q[2]', 'body.Q[3]', 'body.Q[4]', 'body.w_a[1]', 'body.w_a[2]', 'body.w_a[3]', 'bodyBox.body.Q[1]', 'bodyBox.body.Q[2]', 'bodyBox.body.Q[3]', 'bodyBox.body.Q[4]', 'bodyBox.body.frame_a.r_0[1]', 'bodyBox.body.frame_a.r_0[2]', 'bodyBox.body.frame_a.r_0[3]', 'bodyBox.body.w_a[1]', 'bodyBox.body.w_a[2]', 'bodyBox.body.w_a[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]', 'sphericalSpherical.v_CM_0[1]', 'sphericalSpherical.v_CM_0[2]', 'sphericalSpherical.v_CM_0[3]', 'sphericalSpherical1.v_CM_0[1]', 'sphericalSpherical1.v_CM_0[2]', 'sphericalSpherical1.v_CM_0[3]']
26.350585133768618 26.358297345 25.98833167
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x719d0d2c1520>