Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.0.0_Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo) Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo) Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo) Running command: "" <> buildModelFMU(Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b,fileNamePrefix="Modelica_4_0_0_Modelica_Mechanics_MultiBody_Examples_Loops_Engine1b",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b,fileNamePrefix="Modelica_4_0_0_Modelica_Mechanics_MultiBody_Examples_Loops_Engine1b",fmuType="me",version="2.0",platforms={"static"}) Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00128/0.00128, allocations: 106.4 kB / 17.06 MB, free: 6.027 MB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001373/0.001374, allocations: 195 kB / 18 MB, free: 5.105 MB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.31/1.31, allocations: 222.9 MB / 241.7 MB, free: 15.16 MB / 206.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001015/0.001015, allocations: 47.92 kB / 350.8 MB, free: 3.703 MB / 286.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.2199/0.2209, allocations: 49.43 MB / 400.3 MB, free: 8.41 MB / 318.1 MB Notification: Performance of NFInst.instantiate(Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b): time 0.01966/0.2406, allocations: 20.53 MB / 420.8 MB, free: 4.184 MB / 334.1 MB Notification: Performance of NFInst.instExpressions: time 0.01239/0.2531, allocations: 6.181 MB / 427 MB, free: 13.98 MB / 350.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.003338/0.2564, allocations: 167.4 kB / 427.2 MB, free: 13.82 MB / 350.1 MB Notification: Performance of NFTyping.typeComponents: time 0.01092/0.2674, allocations: 6.351 MB / 433.5 MB, free: 7.449 MB / 350.1 MB Notification: Performance of NFTyping.typeBindings: time 0.008057/0.2755, allocations: 3.424 MB / 436.9 MB, free: 4.012 MB / 350.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.003848/0.2794, allocations: 1.665 MB / 438.6 MB, free: 2.344 MB / 350.1 MB Notification: Performance of NFFlatten.flatten: time 0.01649/0.2959, allocations: 12.66 MB / 451.2 MB, free: 5.66 MB / 366.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.01067/0.3066, allocations: 8.053 MB / 459.3 MB, free: 13.52 MB / 382.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.006483/0.3131, allocations: 3.751 MB / 463.1 MB, free: 9.758 MB / 382.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.007591/0.3208, allocations: 4.978 MB / 468 MB, free: 4.766 MB / 382.1 MB Notification: Performance of NFPackage.collectConstants: time 0.002888/0.3237, allocations: 0.7461 MB / 468.8 MB, free: 4.02 MB / 382.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.004715/0.3284, allocations: 1.717 MB / 470.5 MB, free: 2.301 MB / 382.1 MB Notification: Performance of NFScalarize.scalarize: time 0.005739/0.3342, allocations: 4.438 MB / 474.9 MB, free: 13.85 MB / 398.1 MB Notification: Performance of NFVerifyModel.verify: time 0.008181/0.3424, allocations: 4.958 MB / 479.9 MB, free: 8.867 MB / 398.1 MB Notification: Performance of NFConvertDAE.convert: time 0.01671/0.3592, allocations: 14.87 MB / 494.8 MB, free: 9.945 MB / 414.1 MB Notification: Performance of FrontEnd - DAE generated: time 6.984e-06/0.3592, allocations: 0 / 494.8 MB, free: 9.945 MB / 414.1 MB Notification: Performance of FrontEnd: time 1.603e-06/0.3592, allocations: 0 / 494.8 MB, free: 9.945 MB / 414.1 MB Notification: Performance of Transformations before backend: time 0.0004564/0.3597, allocations: 0 / 494.8 MB, free: 9.945 MB / 414.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 2489 * Number of variables: 2489 Notification: Performance of Generate backend data structure: time 0.03048/0.3902, allocations: 10.69 MB / 0.4936 GB, free: 15.16 MB / 430.1 MB Notification: Performance of prepare preOptimizeDAE: time 4.542e-05/0.3902, allocations: 8.031 kB / 0.4936 GB, free: 15.15 MB / 430.1 MB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.003109/0.3934, allocations: 1.197 MB / 0.4948 GB, free: 13.94 MB / 430.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.301/0.6944, allocations: 24.28 MB / 0.5185 GB, free: 5.617 MB / 446.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.02148/0.7159, allocations: 9.95 MB / 0.5282 GB, free: 11.57 MB / 462.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004205/0.7163, allocations: 451.7 kB / 0.5286 GB, free: 11.13 MB / 462.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.002229/0.7186, allocations: 0.6049 MB / 0.5292 GB, free: 10.53 MB / 462.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.3501/1.069, allocations: 16.75 MB / 0.5456 GB, free: 119.8 MB / 462.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 0.0003213/1.069, allocations: 93.2 kB / 0.5457 GB, free: 119.7 MB / 462.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0009857/1.07, allocations: 281.8 kB / 0.546 GB, free: 119.6 MB / 462.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.003519/1.074, allocations: 2.863 MB / 0.5488 GB, free: 119.1 MB / 462.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02246/1.096, allocations: 13.27 MB / 0.5617 GB, free: 112.8 MB / 462.1 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.05952/1.156, allocations: 68.04 MB / 0.6282 GB, free: 43.68 MB / 462.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.01739/1.173, allocations: 7.908 MB / 0.6359 GB, free: 35.63 MB / 462.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.004524/1.178, allocations: 4.318 MB / 0.6401 GB, free: 31.3 MB / 462.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.01662/1.194, allocations: 12.04 MB / 0.6519 GB, free: 19.06 MB / 462.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.589e-05/1.194, allocations: 72.5 kB / 0.6519 GB, free: 18.98 MB / 462.1 MB Notification: Performance of pre-optimization done (n=294): time 4.418e-06/1.194, allocations: 0 / 0.6519 GB, free: 18.98 MB / 462.1 MB Notification: Performance of matching and sorting (n=360): time 0.1744/1.369, allocations: 49.91 MB / 0.7007 GB, free: 1.102 MB / 494.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001876/1.369, allocations: 406.2 kB / 0.701 GB, free: 0.6172 MB / 494.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01026/1.379, allocations: 7.308 MB / 0.7082 GB, free: 9.348 MB / 0.4982 GB Notification: Performance of collectPreVariables (initialization): time 0.0007092/1.38, allocations: 77.7 kB / 0.7083 GB, free: 9.266 MB / 0.4982 GB Notification: Performance of collectInitialEqns (initialization): time 0.003938/1.384, allocations: 5.355 MB / 0.7135 GB, free: 3.852 MB / 0.4982 GB Notification: Performance of collectInitialBindings (initialization): time 0.001665/1.386, allocations: 1.311 MB / 0.7148 GB, free: 2.523 MB / 0.4982 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.00281/1.388, allocations: 1.698 MB / 0.7164 GB, free: 0.8086 MB / 0.4982 GB Notification: Performance of setup shared object (initialization): time 9.174e-05/1.389, allocations: 305.1 kB / 0.7167 GB, free: 0.5078 MB / 0.4982 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.00591/1.394, allocations: 4.128 MB / 0.7207 GB, free: 12.37 MB / 0.5138 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.008595/1.403, allocations: 8.862 MB / 0.7294 GB, free: 1.18 MB / 0.5138 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.1972/1.6, allocations: 13.96 MB / 0.743 GB, free: 156.1 MB / 0.5138 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.558e-05/1.6, allocations: 50.34 kB / 0.7431 GB, free: 156.1 MB / 0.5138 GB Notification: Performance of matching and sorting (n=1107) (initialization): time 0.03094/1.631, allocations: 17.87 MB / 0.7605 GB, free: 150.3 MB / 0.5138 GB Notification: Performance of prepare postOptimizeDAE: time 7.662e-05/1.631, allocations: 72.91 kB / 0.7606 GB, free: 150.3 MB / 0.5138 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001226/1.632, allocations: 169.9 kB / 0.7608 GB, free: 150.3 MB / 0.5138 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.01644/1.648, allocations: 6.063 MB / 0.7667 GB, free: 149.1 MB / 0.5138 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005118/1.653, allocations: 1.824 MB / 0.7685 GB, free: 148.3 MB / 0.5138 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03393/1.687, allocations: 32.9 MB / 0.8006 GB, free: 115.5 MB / 0.5138 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006437/1.694, allocations: 0.5364 MB / 0.8011 GB, free: 115 MB / 0.5138 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0009273/1.695, allocations: 488 kB / 0.8016 GB, free: 114.5 MB / 0.5138 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 743 * Number of states: 0 () * Number of discrete variables: 72 (rod3.color[3],rod3.color[2],rod3.color[1],rod1.color[3],rod1.color[2],rod1.color[1],cylinder.boxColor[3],cylinder.boxColor[2],cylinder.boxColor[1],b2.cylinderColor[3],b2.cylinderColor[2],b2.cylinderColor[1],b1.cylinderColor[3],b1.cylinderColor[2],b1.cylinderColor[1],cylPosition.color[3],cylPosition.color[2],cylPosition.color[1],mid.color[3],mid.color[2],mid.color[1],crank4.color[3],crank4.color[2],crank4.color[1],crank4.body.sphereColor[3],crank4.body.sphereColor[2],crank4.body.sphereColor[1],crank3.color[3],crank3.color[2],crank3.color[1],crank3.body.sphereColor[3],crank3.body.sphereColor[2],crank3.body.sphereColor[1],crank2.color[3],crank2.color[2],crank2.color[1],crank2.body.sphereColor[3],crank2.body.sphereColor[2],crank2.body.sphereColor[1],crank1.color[3],crank1.color[2],crank1.color[1],crank1.body.sphereColor[3],crank1.body.sphereColor[2],crank1.body.sphereColor[1],bearing.cylinderColor[3],bearing.cylinderColor[2],bearing.cylinderColor[1],connectingRod.color[3],connectingRod.color[2],connectingRod.color[1],connectingRod.body.sphereColor[3],connectingRod.body.sphereColor[2],connectingRod.body.sphereColor[1],piston.color[3],piston.color[2],piston.color[1],piston.body.sphereColor[3],piston.body.sphereColor[2],piston.body.sphereColor[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 (968): * Single equations (assignments): 962 * Array equations: 3 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 3 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 2 systems {(8,96,51.6%), (3,5,88.9%)} * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(2,4)} Notification: Performance of prepare postOptimizeDAE: time 0.004009/1.699, allocations: 3.582 MB / 0.8051 GB, free: 111 MB / 0.5138 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001002/1.7, allocations: 0.6834 MB / 0.8057 GB, free: 110.7 MB / 0.5138 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02083/1.72, allocations: 12.09 MB / 0.8176 GB, free: 98.52 MB / 0.5138 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.717e-05/1.721, allocations: 36 kB / 0.8176 GB, free: 98.48 MB / 0.5138 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 2.229e-05/1.721, allocations: 20 kB / 0.8176 GB, free: 98.46 MB / 0.5138 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.105e-05/1.721, allocations: 15.94 kB / 0.8176 GB, free: 98.45 MB / 0.5138 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.03981/1.76, allocations: 25.88 MB / 0.8429 GB, free: 72.29 MB / 0.5138 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.401e-05/1.76, allocations: 4.5 kB / 0.8429 GB, free: 72.29 MB / 0.5138 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001994/1.762, allocations: 476 kB / 0.8434 GB, free: 71.82 MB / 0.5138 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.01537/1.778, allocations: 5.698 MB / 0.8489 GB, free: 66.12 MB / 0.5138 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.000541/1.778, allocations: 64 kB / 0.849 GB, free: 66.05 MB / 0.5138 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03206/1.81, allocations: 31.7 MB / 0.8799 GB, free: 34.13 MB / 0.5138 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.448e-06/1.811, allocations: 4 kB / 0.8799 GB, free: 34.13 MB / 0.5138 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02599/1.837, allocations: 17.41 MB / 0.8969 GB, free: 16.59 MB / 0.5138 GB Notification: Performance of postOpt removeConstants (simulation): time 0.003797/1.84, allocations: 1.368 MB / 0.8983 GB, free: 15.21 MB / 0.5138 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001316/1.842, allocations: 60 kB / 0.8983 GB, free: 15.15 MB / 0.5138 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003711/1.845, allocations: 275.6 kB / 0.8986 GB, free: 14.88 MB / 0.5138 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008927/1.846, allocations: 258.6 kB / 0.8988 GB, free: 14.63 MB / 0.5138 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002946/1.847, allocations: 99.98 kB / 0.8989 GB, free: 14.53 MB / 0.5138 GB Notification: Performance of sorting global known variables: time 0.005896/1.853, allocations: 4.71 MB / 0.9035 GB, free: 9.859 MB / 0.5138 GB Notification: Performance of sort global known variables: time 6.81e-07/1.853, allocations: 4 kB / 0.9035 GB, free: 9.855 MB / 0.5138 GB Notification: Performance of remove unused functions: time 0.007311/1.86, allocations: 2.049 MB / 0.9055 GB, free: 7.809 MB / 0.5138 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 26 * Number of states: 2 (inertia.phi,inertia.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 (232): * Single equations (assignments): 226 * Array equations: 3 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 3 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 2 systems {(7,90,55.1%), (2,4,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(2,6)} Notification: Performance of Backend phase and start with SimCode phase: time 0.03044/1.89, allocations: 18.12 MB / 0.9232 GB, free: 5.508 MB / 0.5294 GB Notification: Performance of simCode: created initialization part: time 0.1776/2.068, allocations: 10.97 MB / 0.9339 GB, free: 184.4 MB / 0.5294 GB Notification: Performance of simCode: created event and clocks part: time 8.767e-06/2.068, allocations: 3.969 kB / 0.934 GB, free: 184.4 MB / 0.5294 GB Notification: Performance of simCode: created simulation system equations: time 0.007234/2.075, allocations: 4.973 MB / 0.9388 GB, free: 182.7 MB / 0.5294 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004982/2.08, allocations: 1.109 MB / 0.9399 GB, free: 182.2 MB / 0.5294 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1119/2.192, allocations: 94.84 MB / 1.033 GB, free: 90.83 MB / 0.5294 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.005351/2.198, allocations: 5.736 MB / 1.038 GB, free: 85.05 MB / 0.5294 GB Notification: Performance of simCode: alias equations: time 0.005015/2.203, allocations: 2.709 MB / 1.041 GB, free: 82.34 MB / 0.5294 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003552/2.206, allocations: 3.889 MB / 1.045 GB, free: 78.45 MB / 0.5294 GB Notification: Performance of SimCode: time 6.21e-07/2.206, allocations: 0 / 1.045 GB, free: 78.45 MB / 0.5294 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 2.363/4.569, allocations: 167.4 MB / 1.208 GB, free: 107.1 MB / 0.5294 GB Notification: Performance of buildModelFMU: Generate platform static: time 42.85/47.42, allocations: 4 kB / 1.208 GB, free: 107.1 MB / 0.5294 GB (rm -f Modelica_4.0.0_Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b.pipe ; mkfifo Modelica_4.0.0_Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b.pipe ; head -c 1048576 < Modelica_4.0.0_Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b.pipe >> ../files/Modelica_4.0.0_Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Modelica_4.0.0_Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b_res.mat --tempDir=temp_Modelica_4_0_0_Modelica_Mechanics_MultiBody_Examples_Loops_Engine1b_fmu --startTime=0 --stopTime=0.5 --timeout=50 --tolerance=1e-06 Modelica_4_0_0_Modelica_Mechanics_MultiBody_Examples_Loops_Engine1b.fmu > Modelica_4.0.0_Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b.pipe 2>&1) diffSimulationResults("Modelica_4.0.0_Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/Modelica/Mechanics/MultiBody/Examples/Loops/Engine1b/Engine1b.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Modelica_4.0.0_Modelica.Mechanics.MultiBody.Examples.Loops.Engine1b.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) Reference file matches