Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.InitializationConversion.Rotor1D.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo", uses=false)
Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/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: "" <> buildModelFMU(ModelicaTest.MultiBody.InitializationConversion.Rotor1D,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_InitializationConversion_Rotor1D",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.MultiBody.InitializationConversion.Rotor1D,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_InitializationConversion_Rotor1D",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.00139/0.00139, allocations: 103.8 kB / 17.63 MB, free: 5.48 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001532/0.001532, allocations: 214.4 kB / 18.59 MB, free: 4.531 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.485/1.485, allocations: 227.4 MB / 246.8 MB, free: 10.51 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo): time 0.2414/0.2414, allocations: 46.11 MB / 344.2 MB, free: 11.55 MB / 286.1 MB
Warning: Requested package Modelica of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions.
Notification: Performance of FrontEnd - loaded program: time 0.003636/0.003637, allocations: 80.83 kB / 417.7 MB, free: 19.6 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1768/0.1804, allocations: 62.46 MB / 480.2 MB, free: 5.125 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.InitializationConversion.Rotor1D): time 0.01842/0.1989, allocations: 15.91 MB / 496.1 MB, free: 5.141 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.009588/0.2085, allocations: 3.858 MB / 500 MB, free: 1.27 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004347/0.2129, allocations: 95.69 kB / 0.4884 GB, free: 1.176 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.00712/0.2201, allocations: 3.099 MB / 0.4914 GB, free: 14.07 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.005632/0.2258, allocations: 1.753 MB / 0.4931 GB, free: 12.3 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00178/0.2276, allocations: 459.2 kB / 0.4935 GB, free: 11.86 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.00735/0.235, allocations: 4 MB / 0.4974 GB, free: 7.844 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.006648/0.2417, allocations: 3.597 MB / 0.5009 GB, free: 4.18 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.00407/0.2458, allocations: 1.881 MB / 0.5028 GB, free: 2.293 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.2464/0.4923, allocations: 2.991 MB / 0.5057 GB, free: 14.91 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.002884/0.4952, allocations: 497.1 kB / 0.5062 GB, free: 14.91 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003768/0.499, allocations: 0.9366 MB / 0.5071 GB, free: 14.91 MB / 382.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.003908/0.503, allocations: 2.229 MB / 0.5093 GB, free: 14.91 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.005066/0.5081, allocations: 2.779 MB / 0.512 GB, free: 14.25 MB / 382.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.009594/0.5177, allocations: 8.411 MB / 0.5202 GB, free: 13.1 MB / 382.1 MB
Notification: Performance of FrontEnd - DAE generated: time 6.361e-06/0.5177, allocations: 1.031 kB / 0.5202 GB, free: 13.1 MB / 382.1 MB
Notification: Performance of FrontEnd: time 1.453e-06/0.5178, allocations: 0 / 0.5202 GB, free: 13.1 MB / 382.1 MB
Notification: Performance of Transformations before backend: time 0.0002692/0.518, allocations: 0 / 0.5202 GB, free: 13.1 MB / 382.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1705
 * Number of variables: 1705
Notification: Performance of Generate backend data structure: time 0.09508/0.6131, allocations: 11.17 MB / 0.5311 GB, free: 8.5 MB / 382.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.018e-05/0.6132, allocations: 10.34 kB / 0.5311 GB, free: 8.5 MB / 382.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.003922/0.6171, allocations: 0.8206 MB / 0.5319 GB, free: 7.961 MB / 382.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008047/0.6252, allocations: 1.86 MB / 0.5337 GB, free: 6.973 MB / 382.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006841/0.6321, allocations: 3.274 MB / 0.5369 GB, free: 4.898 MB / 382.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002175/0.6323, allocations: 294.5 kB / 0.5372 GB, free: 4.797 MB / 382.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002734/0.6351, allocations: 405.1 kB / 0.5376 GB, free: 4.691 MB / 382.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05688/0.6919, allocations: 19.55 MB / 0.5567 GB, free: 3.648 MB / 398.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003139/0.6923, allocations: 55.44 kB / 0.5567 GB, free: 3.613 MB / 398.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002978/0.6953, allocations: 181 kB / 0.5569 GB, free: 3.473 MB / 398.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.006342/0.7017, allocations: 2.341 MB / 0.5592 GB, free: 1.164 MB / 398.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05879/0.7605, allocations: 22.39 MB / 0.5811 GB, free: 10.95 MB / 430.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.08067/0.8412, allocations: 52.52 MB / 0.6324 GB, free: 5.668 MB / 478.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.07012/0.9114, allocations: 9.164 MB / 0.6413 GB, free: 12.36 MB / 494.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004477/0.9159, allocations: 3.021 MB / 0.6443 GB, free: 9.328 MB / 494.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.001811/0.9177, allocations: 367 kB / 0.6446 GB, free: 8.988 MB / 494.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.014e-05/0.9178, allocations: 50.5 kB / 0.6447 GB, free: 8.934 MB / 494.1 MB
Notification: Performance of pre-optimization done (n=212): time 5.57e-06/0.9178, allocations: 4 kB / 0.6447 GB, free: 8.93 MB / 494.1 MB
Notification: Performance of matching and sorting (n=212): time 0.14/1.058, allocations: 16.1 MB / 0.6604 GB, free: 8.816 MB / 0.4981 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000122/1.058, allocations: 153.3 kB / 0.6605 GB, free: 8.641 MB / 0.4981 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.009424/1.067, allocations: 4.686 MB / 0.6651 GB, free: 3.941 MB / 0.4981 GB
Notification: Performance of collectPreVariables (initialization): time 0.0005861/1.068, allocations: 53.7 kB / 0.6652 GB, free: 3.883 MB / 0.4981 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00335/1.071, allocations: 3.488 MB / 0.6686 GB, free: 404 kB / 0.4981 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00148/1.073, allocations: 0.8411 MB / 0.6694 GB, free: 15.56 MB / 0.5137 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002946/1.076, allocations: 1.536 MB / 0.6709 GB, free: 14.01 MB / 0.5137 GB
Notification: Performance of setup shared object (initialization): time 0.0001478/1.076, allocations: 309.1 kB / 0.6712 GB, free: 13.71 MB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005207/1.081, allocations: 3.175 MB / 0.6743 GB, free: 10.53 MB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01171/1.093, allocations: 7.458 MB / 0.6816 GB, free: 1.004 MB / 0.5137 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01698/1.11, allocations: 11.48 MB / 0.6928 GB, free: 4 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001551/1.11, allocations: 46.72 kB / 0.6928 GB, free: 3.957 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=879) (initialization): time 0.02427/1.134, allocations: 10.59 MB / 0.7032 GB, free: 9.789 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003039/1.135, allocations: 72.03 kB / 0.7032 GB, free: 9.719 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0004346/1.135, allocations: 152 kB / 0.7034 GB, free: 9.57 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000388/1.136, allocations: 204 kB / 0.7036 GB, free: 9.371 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007683/1.143, allocations: 1.801 MB / 0.7053 GB, free: 7.566 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0004767/1.144, allocations: 306.8 kB / 0.7056 GB, free: 7.266 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007437/1.151, allocations: 0.9224 MB / 0.7065 GB, free: 6.336 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002028/1.153, allocations: 0.5154 MB / 0.707 GB, free: 5.82 MB / 0.545 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 695
 * Number of states: 0 ()
 * Number of discrete variables: 42 (rotor1D10.cylinderColor[3],rotor1D10.cylinderColor[2],rotor1D10.cylinderColor[1],rotor1D9.cylinderColor[3],rotor1D9.cylinderColor[2],rotor1D9.cylinderColor[1],rotor1D8.cylinderColor[3],rotor1D8.cylinderColor[2],rotor1D8.cylinderColor[1],rotor1D7.cylinderColor[3],rotor1D7.cylinderColor[2],rotor1D7.cylinderColor[1],rotor1D6.cylinderColor[3],rotor1D6.cylinderColor[2],rotor1D6.cylinderColor[1],rotor1D5.cylinderColor[3],rotor1D5.cylinderColor[2],rotor1D5.cylinderColor[1],rotor1D4.cylinderColor[3],rotor1D4.cylinderColor[2],rotor1D4.cylinderColor[1],rotor1D3.cylinderColor[3],rotor1D3.cylinderColor[2],rotor1D3.cylinderColor[1],rotor1D2.cylinderColor[3],rotor1D2.cylinderColor[2],rotor1D2.cylinderColor[1],rotor1D1.cylinderColor[3],rotor1D1.cylinderColor[2],rotor1D1.cylinderColor[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 (855):
 * Single equations (assignments): 852
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.006926/1.16, allocations: 2.311 MB / 0.7093 GB, free: 3.496 MB / 0.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00146/1.162, allocations: 406.8 kB / 0.7097 GB, free: 3.094 MB / 0.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.228/1.39, allocations: 4.854 MB / 0.7144 GB, free: 192.5 MB / 0.545 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.916e-05/1.39, allocations: 24.84 kB / 0.7144 GB, free: 192.5 MB / 0.545 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.398e-05/1.39, allocations: 2.109 kB / 0.7144 GB, free: 192.5 MB / 0.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.381e-05/1.39, allocations: 11.83 kB / 0.7145 GB, free: 192.5 MB / 0.545 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02311/1.413, allocations: 11.54 MB / 0.7257 GB, free: 190.1 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.632e-05/1.413, allocations: 7.844 kB / 0.7257 GB, free: 190.1 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00286/1.416, allocations: 0.5936 MB / 0.7263 GB, free: 190.1 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (simulation): time 3.928e-05/1.416, allocations: 15.06 kB / 0.7263 GB, free: 190.1 MB / 0.545 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0004193/1.417, allocations: 151.5 kB / 0.7265 GB, free: 190.1 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.447e-05/1.417, allocations: 14.62 kB / 0.7265 GB, free: 190.1 MB / 0.545 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.076e-05/1.417, allocations: 12.84 kB / 0.7265 GB, free: 190.1 MB / 0.545 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.009112/1.426, allocations: 8.899 MB / 0.7352 GB, free: 187.2 MB / 0.545 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001588/1.427, allocations: 0.5096 MB / 0.7357 GB, free: 186.8 MB / 0.545 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0009142/1.428, allocations: 48.58 kB / 0.7357 GB, free: 186.8 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002071/1.43, allocations: 84.72 kB / 0.7358 GB, free: 186.8 MB / 0.545 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003692/1.431, allocations: 238.9 kB / 0.736 GB, free: 186.8 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002373/1.431, allocations: 170.2 kB / 0.7362 GB, free: 186.7 MB / 0.545 GB
Notification: Performance of sorting global known variables: time 0.005846/1.437, allocations: 2.949 MB / 0.7391 GB, free: 185.7 MB / 0.545 GB
Notification: Performance of sort global known variables: time 2.4e-07/1.437, allocations: 0 / 0.7391 GB, free: 185.7 MB / 0.545 GB
Notification: Performance of remove unused functions: time 0.007042/1.444, allocations: 1.362 MB / 0.7404 GB, free: 185.4 MB / 0.545 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 34
 * Number of states: 20 (rotor1D1.phi,rotor1D1.w,rotor1D2.phi,rotor1D2.w,rotor1D3.phi,rotor1D3.w,rotor1D4.phi,rotor1D4.w,rotor1D5.phi,rotor1D5.w,rotor1D6.phi,rotor1D6.w,rotor1D7.phi,rotor1D7.w,rotor1D8.phi,rotor1D8.w,rotor1D9.phi,rotor1D9.w,rotor1D10.phi,rotor1D10.w)
 * 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 (208):
 * Single equations (assignments): 205
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.009174/1.453, allocations: 9.567 MB / 0.7498 GB, free: 178 MB / 0.545 GB
Notification: Performance of simCode: created initialization part: time 0.01115/1.464, allocations: 8.845 MB / 0.7584 GB, free: 170.2 MB / 0.545 GB
Notification: Performance of simCode: created event and clocks part: time 1.237e-05/1.464, allocations: 2 kB / 0.7584 GB, free: 170.2 MB / 0.545 GB
Notification: Performance of simCode: created simulation system equations: time 0.002527/1.467, allocations: 2.443 MB / 0.7608 GB, free: 168.1 MB / 0.545 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003703/1.471, allocations: 0.5613 MB / 0.7613 GB, free: 167.6 MB / 0.545 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.07141/1.542, allocations: 67.16 MB / 0.8269 GB, free: 91.73 MB / 0.545 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00587/1.548, allocations: 3.592 MB / 0.8304 GB, free: 88.1 MB / 0.545 GB
Notification: Performance of simCode: alias equations: time 0.005913/1.554, allocations: 2.301 MB / 0.8327 GB, free: 85.8 MB / 0.545 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004056/1.558, allocations: 2.49 MB / 0.8351 GB, free: 83.3 MB / 0.545 GB
Notification: Performance of SimCode: time 1.213e-06/1.558, allocations: 0 / 0.8351 GB, free: 83.3 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.3583/1.916, allocations: 97.9 MB / 0.9307 GB, free: 191.9 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate platform static: time 10.81/12.73, allocations: 15.77 kB / 0.9307 GB, free: 191.9 MB / 0.545 GB
(rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.InitializationConversion.Rotor1D.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.InitializationConversion.Rotor1D.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.InitializationConversion.Rotor1D.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.InitializationConversion.Rotor1D.sim & python3 -m fmpy simulate  --output-file ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.InitializationConversion.Rotor1D_res.csv --start-time 0 --stop-time 1.1 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.00044 ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_InitializationConversion_Rotor1D.fmu > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.InitializationConversion.Rotor1D.pipe 2>&1)