Running command: translateModel(ModelicaTest.MultiBody.FourbarVariants.JointUSR,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|j2.s|j2.v",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.MultiBody.FourbarVariants.JointUSR")
Notification: Performance of loadModel(ModelicaTest): time 1.963/1.963, allocations: 209.3 MB / 223.8 MB, free: 440 kB / 186.7 MB
Notification: Performance of FrontEnd - loaded program: time 3.328e-05/3.327e-05, allocations: 4 kB / 276.2 MB, free: 15.2 MB / 234.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3626/0.3626, allocations: 48.7 MB / 324.9 MB, free: 3.359 MB / 266.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.FourbarVariants.JointUSR): time 0.07807/0.4408, allocations: 49.97 MB / 374.8 MB, free: 13.39 MB / 314.7 MB
Notification: Performance of NFInst.instExpressions: time 0.03561/0.4764, allocations: 11.53 MB / 386.4 MB, free: 1.828 MB / 314.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01339/0.4899, allocations: 263.4 kB / 386.6 MB, free: 1.57 MB / 314.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.01102/0.501, allocations: 2.625 MB / 389.3 MB, free: 14.93 MB / 330.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.03018/0.5312, allocations: 7.211 MB / 396.5 MB, free: 7.703 MB / 330.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005981/0.5372, allocations: 1.236 MB / 397.7 MB, free: 6.465 MB / 330.7 MB
Notification: Performance of NFFlatten.flatten: time 0.03283/0.5701, allocations: 10.98 MB / 408.7 MB, free: 11.48 MB / 346.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01476/0.5849, allocations: 7.036 MB / 415.7 MB, free: 4.387 MB / 346.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004366/0.5893, allocations: 1.609 MB / 417.3 MB, free: 2.773 MB / 346.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.005917/0.5953, allocations: 2.705 MB / 420 MB, free: 64 kB / 346.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.005144/0.6005, allocations: 1.295 MB / 421.3 MB, free: 14.76 MB / 362.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.002269/0.6028, allocations: 252 kB / 421.6 MB, free: 14.52 MB / 362.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.005439/0.6083, allocations: 2.934 MB / 424.5 MB, free: 11.58 MB / 362.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.002544/0.6109, allocations: 488 kB / 425 MB, free: 11.1 MB / 362.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01685/0.6277, allocations: 10.62 MB / 435.6 MB, free: 468 kB / 362.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.488e-06/0.6278, allocations: 0 / 435.6 MB, free: 468 kB / 362.7 MB
Notification: Performance of FrontEnd: time 2.675e-06/0.6278, allocations: 0 / 435.6 MB, free: 468 kB / 362.7 MB
Notification: Performance of Transformations before backend: time 0.0004401/0.6283, allocations: 0 / 435.6 MB, free: 468 kB / 362.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2779
 * Number of variables: 2779
Notification: Performance of Generate backend data structure: time 0.02817/0.6565, allocations: 7.521 MB / 443.1 MB, free: 8.855 MB / 378.7 MB
Notification: Performance of prepare preOptimizeDAE: time 6.08e-05/0.6565, allocations: 8.031 kB / 443.1 MB, free: 8.848 MB / 378.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.08364/0.7402, allocations: 9.252 MB / 452.4 MB, free: 15.57 MB / 394.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02009/0.7603, allocations: 6.011 MB / 458.4 MB, free: 9.473 MB / 394.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000648/0.761, allocations: 430.9 kB / 458.8 MB, free: 9.051 MB / 394.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003485/0.7645, allocations: 0.6048 MB / 459.4 MB, free: 8.445 MB / 394.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0646/0.8292, allocations: 20.83 MB / 480.3 MB, free: 2.48 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004298/0.8297, allocations: 83.23 kB / 480.3 MB, free: 2.398 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003292/0.833, allocations: 275.7 kB / 480.6 MB, free: 2.129 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.5456/1.379, allocations: 3.698 MB / 484.3 MB, free: 119.6 MB / 410.8 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.06227/1.441, allocations: 18.36 MB / 0.4909 GB, free: 114.3 MB / 410.8 MB
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.1289/1.57, allocations: 74.47 MB / 0.5636 GB, free: 44.02 MB / 410.8 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.02907/1.599, allocations: 7.461 MB / 0.5709 GB, free: 36.32 MB / 410.8 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.04384/1.643, allocations: 18.14 MB / 0.5886 GB, free: 17.62 MB / 410.8 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.579e-05/1.643, allocations: 76.48 kB / 0.5887 GB, free: 17.54 MB / 410.8 MB
Notification: Performance of pre-optimization done (n=332): time 8.476e-06/1.643, allocations: 3.938 kB / 0.5887 GB, free: 17.54 MB / 410.8 MB
Notification: Performance of matching and sorting (n=413): time 0.2143/1.857, allocations: 35.71 MB / 0.6236 GB, free: 13.57 MB / 442.8 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001437/1.858, allocations: 196.9 kB / 0.6237 GB, free: 13.34 MB / 442.8 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01593/1.874, allocations: 6.234 MB / 0.6298 GB, free: 7.113 MB / 442.8 MB
Notification: Performance of collectPreVariables (initialization): time 0.0009742/1.875, allocations: 85.69 kB / 0.6299 GB, free: 7.023 MB / 442.8 MB
Notification: Performance of collectInitialEqns (initialization): time 0.007243/1.882, allocations: 5.421 MB / 0.6352 GB, free: 1.602 MB / 442.8 MB
Notification: Performance of collectInitialBindings (initialization): time 0.00331/1.885, allocations: 1.519 MB / 0.6367 GB, free: 96 kB / 442.8 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.2928/2.178, allocations: 207.1 kB / 0.6369 GB, free: 140.1 MB / 442.8 MB
Notification: Performance of setup shared object (initialization): time 0.001144/2.179, allocations: 0.7461 MB / 0.6376 GB, free: 139.8 MB / 442.8 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01233/2.192, allocations: 4.131 MB / 0.6416 GB, free: 138.7 MB / 442.8 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01721/2.209, allocations: 9.963 MB / 0.6514 GB, free: 129.5 MB / 442.8 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01662/2.225, allocations: 6.289 MB / 0.6575 GB, free: 127 MB / 442.8 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0003116/2.226, allocations: 58.19 kB / 0.6576 GB, free: 127 MB / 442.8 MB
Notification: Performance of matching and sorting (n=1374) (initialization): time 0.05207/2.278, allocations: 15.82 MB / 0.673 GB, free: 121.5 MB / 442.8 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001713/2.278, allocations: 92.72 kB / 0.6731 GB, free: 121.5 MB / 442.8 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003131/2.278, allocations: 203.3 kB / 0.6733 GB, free: 121.5 MB / 442.8 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01343/2.292, allocations: 2.343 MB / 0.6756 GB, free: 121.1 MB / 442.8 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01528/2.307, allocations: 2.392 MB / 0.6779 GB, free: 120.9 MB / 442.8 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02988/2.337, allocations: 12.07 MB / 0.6897 GB, free: 113 MB / 442.8 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01203/2.349, allocations: 0.5882 MB / 0.6903 GB, free: 112.5 MB / 442.8 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002205/2.352, allocations: 0.5877 MB / 0.6909 GB, free: 111.9 MB / 442.8 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 934
 * Number of states: 0 ()
 * Number of discrete variables: 46 (jointUSR.revolute.positiveBranch,Body3.sphereColor[3],Body3.sphereColor[2],Body3.sphereColor[1],Body2.sphereColor[3],Body2.sphereColor[2],Body2.sphereColor[1],Body1.sphereColor[3],Body1.sphereColor[2],Body1.sphereColor[1],jointUSR.rod1Color[3],jointUSR.rod1Color[2],jointUSR.rod1Color[1],jointUSR.cylinderColor[3],jointUSR.cylinderColor[2],jointUSR.cylinderColor[1],jointUSR.sphereColor[3],jointUSR.sphereColor[2],jointUSR.sphereColor[1],jointUSR.revoluteColor[3],jointUSR.revoluteColor[2],jointUSR.revoluteColor[1],fixedFrame.color_x[3],fixedFrame.color_x[2],fixedFrame.color_x[1],b3.color[3],b3.color[2],b3.color[1],b2.color[3],b2.color[2],b2.color[1],b2.body.sphereColor[3],b2.body.sphereColor[2],b2.body.sphereColor[1],j2.boxColor[3],j2.boxColor[2],j2.boxColor[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 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1273):
 * Single equations (assignments): 1266
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(2,100.0%) 52}
 * Non-linear torn systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.009413/2.361, allocations: 3.697 MB / 0.6945 GB, free: 108.8 MB / 442.8 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001481/2.362, allocations: 0.5959 MB / 0.6951 GB, free: 108.5 MB / 442.8 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02665/2.389, allocations: 8.144 MB / 0.703 GB, free: 101.1 MB / 442.8 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001183/2.389, allocations: 70.48 kB / 0.7031 GB, free: 101 MB / 442.8 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.288e-05/2.389, allocations: 15.95 kB / 0.7031 GB, free: 101 MB / 442.8 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.921e-05/2.389, allocations: 15.94 kB / 0.7031 GB, free: 101 MB / 442.8 MB
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.05595/2.445, allocations: 18.76 MB / 0.7214 GB, free: 81.98 MB / 442.8 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.772e-05/2.446, allocations: 12 kB / 0.7214 GB, free: 81.97 MB / 442.8 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.005516/2.451, allocations: 0.6162 MB / 0.722 GB, free: 81.36 MB / 442.8 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.01166/2.463, allocations: 1.743 MB / 0.7237 GB, free: 79.61 MB / 442.8 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0007825/2.464, allocations: 85.31 kB / 0.7238 GB, free: 79.53 MB / 442.8 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03615/2.5, allocations: 10.14 MB / 0.7337 GB, free: 69.33 MB / 442.8 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.332e-05/2.5, allocations: 25.02 kB / 0.7338 GB, free: 69.3 MB / 442.8 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.05144/2.551, allocations: 14.07 MB / 0.7475 GB, free: 54.64 MB / 442.8 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.006227/2.558, allocations: 1.175 MB / 0.7486 GB, free: 53.45 MB / 442.8 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003195/2.561, allocations: 76 kB / 0.7487 GB, free: 53.37 MB / 442.8 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.008792/2.57, allocations: 207.8 kB / 0.7489 GB, free: 53.17 MB / 442.8 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001444/2.571, allocations: 257.7 kB / 0.7492 GB, free: 52.91 MB / 442.8 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004879/2.572, allocations: 112.9 kB / 0.7493 GB, free: 52.8 MB / 442.8 MB
Notification: Performance of sorting global known variables: time 0.00983/2.582, allocations: 4.382 MB / 0.7535 GB, free: 48.43 MB / 442.8 MB
Notification: Performance of sort global known variables: time 8.02e-07/2.582, allocations: 2.078 kB / 0.7535 GB, free: 48.43 MB / 442.8 MB
Notification: Performance of remove unused functions: time 0.01147/2.593, allocations: 1.928 MB / 0.7554 GB, free: 46.52 MB / 442.8 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 52
 * Number of states: 2 (j2.s,j2.v)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (325):
 * Single equations (assignments): 318
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(2,100.0%) 42}
 * Non-linear torn systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.001469/2.595, allocations: 276.2 kB / 0.7557 GB, free: 46.25 MB / 442.8 MB
Notification: Performance of simCode: created initialization part: time 0.0233/2.618, allocations: 9.76 MB / 0.7652 GB, free: 36.5 MB / 442.8 MB
Notification: Performance of simCode: created event and clocks part: time 1.595e-05/2.618, allocations: 4 kB / 0.7652 GB, free: 36.5 MB / 442.8 MB
Notification: Performance of simCode: created simulation system equations: time 0.008028/2.626, allocations: 3.297 MB / 0.7685 GB, free: 33.19 MB / 442.8 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005738/2.632, allocations: 0.7216 MB / 0.7692 GB, free: 32.46 MB / 442.8 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.04374/2.676, allocations: 20.64 MB / 0.7893 GB, free: 11.64 MB / 442.8 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01029/2.686, allocations: 5.744 MB / 0.7949 GB, free: 5.859 MB / 442.8 MB
Notification: Performance of simCode: alias equations: time 0.3262/3.012, allocations: 3.32 MB / 0.7982 GB, free: 120.7 MB / 442.8 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003223/3.015, allocations: 419.1 kB / 0.7986 GB, free: 120.7 MB / 442.8 MB
Notification: Performance of SimCode: time 1.784e-06/3.015, allocations: 0 / 0.7986 GB, free: 120.7 MB / 442.8 MB
Notification: Performance of Templates: time 0.2182/3.234, allocations: 69.56 MB / 0.8665 GB, free: 82.18 MB / 442.8 MB