Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.MultiBody.FourbarVariants.JointSSR.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: translateModel(ModelicaTest.MultiBody.FourbarVariants.JointSSR,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|j2.s|j2.v",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.MultiBody.FourbarVariants.JointSSR")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.002648/0.002648, allocations: 353 kB / 15.95 MB, free: 6.219 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 3.494/3.494, allocations: 341.5 MB / 358.2 MB, free: 12.54 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.005441/0.005441, allocations: 217.2 kB / 397.9 MB, free: 4.898 MB / 330.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo): time 0.5606/0.5606, allocations: 76.09 MB / 0.5014 GB, free: 112.6 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0006596/0.0006599, allocations: 12 kB / 0.5592 GB, free: 53.46 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09147/0.09217, allocations: 48.7 MB / 0.6067 GB, free: 4.648 MB / 362.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.FourbarVariants.JointSSR): time 0.3478/0.44, allocations: 50.73 MB / 0.6563 GB, free: 59.04 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.04841/0.4886, allocations: 11.32 MB / 0.6673 GB, free: 50.72 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01549/0.5041, allocations: 239.4 kB / 0.6676 GB, free: 50.49 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0123/0.5165, allocations: 2.446 MB / 0.6699 GB, free: 48.03 MB / 362.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.04198/0.5585, allocations: 8.614 MB / 0.6784 GB, free: 39.41 MB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.007669/0.5663, allocations: 1.084 MB / 0.6794 GB, free: 38.32 MB / 362.7 MB
Notification: Performance of NFFlatten.flatten: time 0.05075/0.6171, allocations: 19.84 MB / 0.6988 GB, free: 18.45 MB / 362.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01911/0.6363, allocations: 7.04 MB / 0.7057 GB, free: 11.51 MB / 362.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.006699/0.643, allocations: 2.117 MB / 0.7077 GB, free: 9.383 MB / 362.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.009613/0.6527, allocations: 3.498 MB / 0.7112 GB, free: 5.875 MB / 362.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.002648/0.6554, allocations: 264 kB / 0.7114 GB, free: 5.617 MB / 362.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.007004/0.6625, allocations: 1.341 MB / 0.7127 GB, free: 4.277 MB / 362.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.006257/0.6688, allocations: 2.895 MB / 0.7155 GB, free: 1.375 MB / 362.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.003809/0.6727, allocations: 1.372 MB / 0.7169 GB, free: 15.99 MB / 378.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.02221/0.695, allocations: 9.563 MB / 0.7262 GB, free: 6.406 MB / 378.7 MB
Notification: Performance of FrontEnd - DAE generated: time 1.215e-05/0.6951, allocations: 4 kB / 0.7262 GB, free: 6.402 MB / 378.7 MB
Notification: Performance of FrontEnd: time 3.286e-06/0.6951, allocations: 0 / 0.7262 GB, free: 6.402 MB / 378.7 MB
Notification: Performance of Transformations before backend: time 0.000417/0.6955, allocations: 0 / 0.7262 GB, free: 6.402 MB / 378.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2561
 * Number of variables: 2561
Notification: Performance of Generate backend data structure: time 0.03229/0.7278, allocations: 6.631 MB / 0.7327 GB, free: 15.69 MB / 394.7 MB
Notification: Performance of prepare preOptimizeDAE: time 6.831e-05/0.7279, allocations: 8.031 kB / 0.7327 GB, free: 15.68 MB / 394.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04857/0.7765, allocations: 4.678 MB / 0.7373 GB, free: 10.98 MB / 394.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02207/0.7987, allocations: 4.304 MB / 0.7415 GB, free: 6.621 MB / 394.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001057/0.7998, allocations: 394 kB / 0.7419 GB, free: 6.234 MB / 394.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00364/0.8035, allocations: 0.5542 MB / 0.7424 GB, free: 5.68 MB / 394.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05946/0.863, allocations: 19.15 MB / 0.7611 GB, free: 1.48 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000283/0.8633, allocations: 59.47 kB / 0.7612 GB, free: 1.422 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001885/0.8652, allocations: 255.8 kB / 0.7614 GB, free: 1.172 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.5783/1.444, allocations: 3.413 MB / 0.7647 GB, free: 117.2 MB / 410.8 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.06188/1.505, allocations: 16.88 MB / 0.7812 GB, free: 113.8 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.1225/1.628, allocations: 66.78 MB / 0.8464 GB, free: 53.92 MB / 410.8 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.02649/1.655, allocations: 6.305 MB / 0.8526 GB, free: 47.38 MB / 410.8 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.006549/1.661, allocations: 2.842 MB / 0.8554 GB, free: 44.52 MB / 410.8 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.03414/1.695, allocations: 13.91 MB / 0.869 GB, free: 30.01 MB / 410.8 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.308e-05/1.695, allocations: 61.08 kB / 0.869 GB, free: 29.94 MB / 410.8 MB
Notification: Performance of pre-optimization done (n=287): time 7.985e-06/1.696, allocations: 4 kB / 0.869 GB, free: 29.94 MB / 410.8 MB
Notification: Performance of matching and sorting (n=354): time 0.1808/1.876, allocations: 26.5 MB / 0.8949 GB, free: 3.43 MB / 410.8 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.73e-05/1.876, allocations: 200.3 kB / 0.8951 GB, free: 3.195 MB / 410.8 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01305/1.889, allocations: 5.856 MB / 0.9008 GB, free: 13.36 MB / 426.8 MB
Notification: Performance of collectPreVariables (initialization): time 0.0007933/1.89, allocations: 80.12 kB / 0.9009 GB, free: 13.28 MB / 426.8 MB
Notification: Performance of collectInitialEqns (initialization): time 0.005773/1.896, allocations: 4.937 MB / 0.9057 GB, free: 8.34 MB / 426.8 MB
Notification: Performance of collectInitialBindings (initialization): time 0.00244/1.899, allocations: 1.308 MB / 0.907 GB, free: 7.043 MB / 426.8 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001168/1.9, allocations: 193.2 kB / 0.9072 GB, free: 6.855 MB / 426.8 MB
Notification: Performance of setup shared object (initialization): time 0.0009278/1.901, allocations: 0.7191 MB / 0.9079 GB, free: 6.129 MB / 426.8 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01069/1.912, allocations: 3.423 MB / 0.9112 GB, free: 2.699 MB / 426.8 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01628/1.928, allocations: 8.904 MB / 0.9199 GB, free: 7.105 MB / 442.8 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01498/1.943, allocations: 5.416 MB / 0.9252 GB, free: 1.672 MB / 442.8 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001833/1.943, allocations: 56 kB / 0.9252 GB, free: 1.617 MB / 442.8 MB
Notification: Performance of matching and sorting (n=1265) (initialization): time 0.439/2.382, allocations: 13.16 MB / 0.9381 GB, free: 129.2 MB / 442.8 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001868/2.382, allocations: 87.25 kB / 0.9382 GB, free: 129.2 MB / 442.8 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003747/2.383, allocations: 192.7 kB / 0.9384 GB, free: 129.2 MB / 442.8 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008829/2.392, allocations: 1.428 MB / 0.9398 GB, free: 128.9 MB / 442.8 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01406/2.406, allocations: 2.197 MB / 0.9419 GB, free: 128.6 MB / 442.8 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02133/2.427, allocations: 7.765 MB / 0.9495 GB, free: 124.7 MB / 442.8 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01022/2.437, allocations: 0.4933 MB / 0.95 GB, free: 124.5 MB / 442.8 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00205/2.44, allocations: 0.5533 MB / 0.9505 GB, free: 124.5 MB / 442.8 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 874
 * Number of states: 0 ()
 * Number of discrete variables: 43 (jointSSR.revolute.positiveBranch,Body2.sphereColor[3],Body2.sphereColor[2],Body2.sphereColor[1],Body1.sphereColor[3],Body1.sphereColor[2],Body1.sphereColor[1],FixedFrame1.color_x[3],FixedFrame1.color_x[2],FixedFrame1.color_x[1],jointSSR.rod1Color[3],jointSSR.rod1Color[2],jointSSR.rod1Color[1],jointSSR.rod1.massColor[3],jointSSR.rod1.massColor[2],jointSSR.rod1.massColor[1],jointSSR.sphereColor[3],jointSSR.sphereColor[2],jointSSR.sphereColor[1],jointSSR.revoluteColor[3],jointSSR.revoluteColor[2],jointSSR.revoluteColor[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 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1179):
 * Single equations (assignments): 1172
 * 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%) 37}
 * Non-linear torn systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.01525/2.455, allocations: 3.453 MB / 0.9539 GB, free: 123 MB / 442.8 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002361/2.457, allocations: 0.5285 MB / 0.9544 GB, free: 123 MB / 442.8 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03357/2.491, allocations: 5.718 MB / 0.96 GB, free: 120.8 MB / 442.8 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001254/2.491, allocations: 14.44 kB / 0.96 GB, free: 120.8 MB / 442.8 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.812e-05/2.491, allocations: 1.875 kB / 0.96 GB, free: 120.8 MB / 442.8 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.005361/2.496, allocations: 1.01 MB / 0.961 GB, free: 120.3 MB / 442.8 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002769/2.499, allocations: 56.7 kB / 0.961 GB, free: 120.3 MB / 442.8 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.007192/2.507, allocations: 164.6 kB / 0.9612 GB, free: 120.3 MB / 442.8 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001444/2.508, allocations: 202.7 kB / 0.9614 GB, free: 120.2 MB / 442.8 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.03253/2.541, allocations: 6.049 MB / 0.9673 GB, free: 118 MB / 442.8 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.02091/2.562, allocations: 8.411 MB / 0.9755 GB, free: 112.4 MB / 442.8 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.005007/2.567, allocations: 2.284 MB / 0.9777 GB, free: 110.4 MB / 442.8 MB
Notification: Performance of sorting global known variables: time 0.01043/2.577, allocations: 3.641 MB / 0.9813 GB, free: 107.4 MB / 442.8 MB
Notification: Performance of Backend: time 1.763e-06/2.577, allocations: 0 / 0.9813 GB, free: 107.4 MB / 442.8 MB
Notification: Performance of simCode: created initialization part: time 0.02994/2.607, allocations: 6.585 MB / 0.9877 GB, free: 101.7 MB / 442.8 MB
Notification: Performance of SimCode: time 0.04011/2.647, allocations: 17.79 MB / 1.005 GB, free: 84.79 MB / 442.8 MB
Notification: Performance of Templates: time 0.1946/2.842, allocations: 70.48 MB / 1.074 GB, free: 15.01 MB / 442.8 MB