Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Rotor1D.Rotor1D_2.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001761/0.001761, allocations: 109.2 kB / 20.42 MB, free: 1.684 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.002238/0.002238, allocations: 219.9 kB / 23.72 MB, free: 5.051 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.513/1.513, allocations: 230.2 MB / 257.1 MB, free: 8.477 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo): time 0.2468/0.2468, allocations: 46.89 MB / 360.3 MB, free: 4.625 MB / 286.1 MB " [Timeout remaining time 179] 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.Parts.Rotor1D.Rotor1D_2,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Parts_Rotor1D_Rotor1D_2",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(ModelicaTest.MultiBody.Parts.Rotor1D.Rotor1D_2,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Parts_Rotor1D_Rotor1D_2",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660] "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.002332/0.002332, allocations: 83.84 kB / 0.4955 GB, free: 8.309 MB / 366.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.3909/0.3932, allocations: 65.98 MB / 0.56 GB, free: 4.926 MB / 398.1 MB Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Parts.Rotor1D.Rotor1D_2): time 0.01402/0.4072, allocations: 11.13 MB / 0.5708 GB, free: 9.75 MB / 414.1 MB Notification: Performance of NFInst.instExpressions: time 0.009588/0.4168, allocations: 3.859 MB / 0.5746 GB, free: 5.875 MB / 414.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.002443/0.4193, allocations: 67.81 kB / 0.5747 GB, free: 5.809 MB / 414.1 MB Notification: Performance of NFTyping.typeComponents: time 0.006088/0.4253, allocations: 2.722 MB / 0.5773 GB, free: 3.078 MB / 414.1 MB Notification: Performance of NFTyping.typeBindings: time 0.005636/0.431, allocations: 1.786 MB / 0.5791 GB, free: 1.285 MB / 414.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.00212/0.4331, allocations: 0.7017 MB / 0.5798 GB, free: 0.582 MB / 414.1 MB Notification: Performance of NFFlatten.flatten: time 0.007031/0.4401, allocations: 3.586 MB / 0.5833 GB, free: 12.99 MB / 430.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.004152/0.4443, allocations: 2.597 MB / 0.5858 GB, free: 10.32 MB / 430.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.003018/0.4473, allocations: 1.464 MB / 0.5872 GB, free: 8.855 MB / 430.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.003805/0.4511, allocations: 2.146 MB / 0.5893 GB, free: 6.703 MB / 430.1 MB Notification: Performance of NFPackage.collectConstants: time 0.001041/0.4521, allocations: 320 kB / 0.5896 GB, free: 6.391 MB / 430.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.002571/0.4547, allocations: 1.088 MB / 0.5907 GB, free: 5.301 MB / 430.1 MB Notification: Performance of NFScalarize.scalarize: time 0.002385/0.4571, allocations: 1.842 MB / 0.5925 GB, free: 3.453 MB / 430.1 MB Notification: Performance of NFVerifyModel.verify: time 0.003418/0.4605, allocations: 2.093 MB / 0.5945 GB, free: 1.348 MB / 430.1 MB Notification: Performance of NFConvertDAE.convert: time 0.009897/0.4704, allocations: 6.704 MB / 0.6011 GB, free: 10.61 MB / 446.1 MB Notification: Performance of FrontEnd - DAE generated: time 1.025e-05/0.4704, allocations: 4 kB / 0.6011 GB, free: 10.61 MB / 446.1 MB Notification: Performance of FrontEnd: time 2.184e-06/0.4704, allocations: 0 / 0.6011 GB, free: 10.61 MB / 446.1 MB Notification: Performance of Transformations before backend: time 0.0002528/0.4707, allocations: 0 / 0.6011 GB, free: 10.61 MB / 446.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1413 * Number of variables: 1413 Notification: Performance of Generate backend data structure: time 0.02001/0.4907, allocations: 5.208 MB / 0.6062 GB, free: 5.328 MB / 446.1 MB Notification: Performance of prepare preOptimizeDAE: time 5.629e-05/0.4908, allocations: 8.031 kB / 0.6062 GB, free: 5.32 MB / 446.1 MB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001648/0.4924, allocations: 0.6742 MB / 0.6068 GB, free: 4.637 MB / 446.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007472/0.4999, allocations: 1.897 MB / 0.6087 GB, free: 2.734 MB / 446.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.006801/0.5067, allocations: 2.499 MB / 0.6111 GB, free: 180 kB / 446.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002604/0.5069, allocations: 217.8 kB / 0.6113 GB, free: 15.96 MB / 462.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.001366/0.5083, allocations: 303.8 kB / 0.6116 GB, free: 15.66 MB / 462.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.02295/0.5313, allocations: 10.04 MB / 0.6214 GB, free: 4.973 MB / 462.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 0.0001642/0.5314, allocations: 43.62 kB / 0.6215 GB, free: 4.93 MB / 462.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007858/0.5322, allocations: 151.9 kB / 0.6216 GB, free: 4.781 MB / 462.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.003654/0.5359, allocations: 1.798 MB / 0.6234 GB, free: 2.977 MB / 462.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02019/0.556, allocations: 9.038 MB / 0.6322 GB, free: 9.914 MB / 478.1 MB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.05458/0.6106, allocations: 37.15 MB / 0.6685 GB, free: 3.707 MB / 0.4981 GB Notification: Performance of preOpt comSubExp (simulation): time 0.01418/0.6248, allocations: 3.604 MB / 0.672 GB, free: 15.95 MB / 0.5137 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.002754/0.6276, allocations: 1.606 MB / 0.6736 GB, free: 14.34 MB / 0.5137 GB Notification: Performance of preOpt evalFunc (simulation): time 0.001163/0.6287, allocations: 0.6785 MB / 0.6742 GB, free: 13.55 MB / 0.5137 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.353e-05/0.6288, allocations: 47.06 kB / 0.6743 GB, free: 13.49 MB / 0.5137 GB Notification: Performance of pre-optimization done (n=130): time 4.108e-06/0.6288, allocations: 0 / 0.6743 GB, free: 13.49 MB / 0.5137 GB Notification: Performance of matching and sorting (n=136): time 0.04618/0.675, allocations: 13.1 MB / 0.6871 GB, free: 300 kB / 0.5137 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001053/0.6751, allocations: 141.2 kB / 0.6872 GB, free: 128 kB / 0.5137 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007254/0.6823, allocations: 3.98 MB / 0.6911 GB, free: 12.16 MB / 0.5294 GB Notification: Performance of collectPreVariables (initialization): time 0.0004224/0.6828, allocations: 41.7 kB / 0.6911 GB, free: 12.12 MB / 0.5294 GB Notification: Performance of collectInitialEqns (initialization): time 0.003271/0.686, allocations: 3.085 MB / 0.6942 GB, free: 9.004 MB / 0.5294 GB Notification: Performance of collectInitialBindings (initialization): time 0.001112/0.6871, allocations: 0.57 MB / 0.6947 GB, free: 8.43 MB / 0.5294 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.001997/0.6891, allocations: 1.143 MB / 0.6958 GB, free: 7.277 MB / 0.5294 GB Notification: Performance of setup shared object (initialization): time 0.0001814/0.6893, allocations: 305.1 kB / 0.6961 GB, free: 6.977 MB / 0.5294 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.003296/0.6926, allocations: 1.924 MB / 0.698 GB, free: 5.047 MB / 0.5294 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.006851/0.6995, allocations: 5.497 MB / 0.7034 GB, free: 13.75 MB / 0.545 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.01074/0.7102, allocations: 8.045 MB / 0.7112 GB, free: 3.918 MB / 0.545 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001235/0.7103, allocations: 36 kB / 0.7113 GB, free: 3.883 MB / 0.545 GB Notification: Performance of matching and sorting (n=716) (initialization): time 0.01756/0.7279, allocations: 7.905 MB / 0.719 GB, free: 11.97 MB / 0.5606 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001123/0.728, allocations: 56.09 kB / 0.719 GB, free: 11.91 MB / 0.5606 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001952/0.7282, allocations: 131.9 kB / 0.7192 GB, free: 11.79 MB / 0.5606 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.002898/0.7311, allocations: 0.9097 MB / 0.72 GB, free: 10.88 MB / 0.5606 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004528/0.7356, allocations: 1.287 MB / 0.7213 GB, free: 9.586 MB / 0.5606 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007693/0.7433, allocations: 5.175 MB / 0.7264 GB, free: 4.27 MB / 0.5606 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004471/0.7478, allocations: 303.8 kB / 0.7266 GB, free: 3.973 MB / 0.5606 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001029/0.7488, allocations: 356 kB / 0.727 GB, free: 3.625 MB / 0.5606 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 579 * Number of states: 0 () * Number of discrete variables: 38 (torque.torqueArrow.twoHeadedArrow,torque.torqueArrow.headAtOrigin,rotor1D.cylinderColor[3],rotor1D.cylinderColor[2],rotor1D.cylinderColor[1],fixed.color[3],fixed.color[2],fixed.color[1],torque.connectionLineColor[3],torque.connectionLineColor[2],torque.connectionLineColor[1],torque.torqueColor[3],torque.torqueColor[2],torque.torqueColor[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],revolute.cylinderColor[3],revolute.cylinderColor[2],revolute.cylinderColor[1],bodyCylinder.color[3],bodyCylinder.color[2],bodyCylinder.color[1],bodyCylinder.body.sphereColor[3],bodyCylinder.body.sphereColor[2],bodyCylinder.body.sphereColor[1],bodyCylinder.frameTranslation.color[3],bodyCylinder.frameTranslation.color[2],bodyCylinder.frameTranslation.color[1]) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (677): * Single equations (assignments): 673 * Array equations: 3 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 1 system {(3,13,77.8%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.004405/0.7532, allocations: 1.963 MB / 0.7289 GB, free: 1.648 MB / 0.5606 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008462/0.7541, allocations: 345.7 kB / 0.7292 GB, free: 1.309 MB / 0.5606 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.3107/1.065, allocations: 2.772 MB / 0.7319 GB, free: 152.8 MB / 0.5606 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.922e-05/1.065, allocations: 16.06 kB / 0.7319 GB, free: 152.8 MB / 0.5606 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 2.553e-05/1.065, allocations: 3.906 kB / 0.732 GB, free: 152.8 MB / 0.5606 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.243e-05/1.065, allocations: 6.938 kB / 0.732 GB, free: 152.8 MB / 0.5606 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01533/1.08, allocations: 7.171 MB / 0.739 GB, free: 150.6 MB / 0.5606 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.657e-05/1.08, allocations: 3.844 kB / 0.739 GB, free: 150.6 MB / 0.5606 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001197/1.081, allocations: 242.9 kB / 0.7392 GB, free: 150.6 MB / 0.5606 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.001997/1.083, allocations: 0.7141 MB / 0.7399 GB, free: 150.5 MB / 0.5606 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002173/1.084, allocations: 40 kB / 0.7399 GB, free: 150.4 MB / 0.5606 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005208/1.089, allocations: 4.762 MB / 0.7446 GB, free: 147.7 MB / 0.5606 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.855e-06/1.089, allocations: 2.969 kB / 0.7446 GB, free: 147.7 MB / 0.5606 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.007087/1.096, allocations: 5.14 MB / 0.7496 GB, free: 146 MB / 0.5606 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0009955/1.097, allocations: 403.7 kB / 0.75 GB, free: 145.9 MB / 0.5606 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004778/1.097, allocations: 23.88 kB / 0.75 GB, free: 145.8 MB / 0.5606 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001268/1.099, allocations: 83.27 kB / 0.7501 GB, free: 145.8 MB / 0.5606 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002538/1.099, allocations: 91.34 kB / 0.7502 GB, free: 145.8 MB / 0.5606 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001064/1.099, allocations: 46.7 kB / 0.7502 GB, free: 145.8 MB / 0.5606 GB Notification: Performance of sorting global known variables: time 0.003483/1.102, allocations: 2.484 MB / 0.7527 GB, free: 144.2 MB / 0.5606 GB Notification: Performance of sort global known variables: time 9e-08/1.102, allocations: 0 / 0.7527 GB, free: 144.2 MB / 0.5606 GB Notification: Performance of remove unused functions: time 0.004735/1.107, allocations: 0.8751 MB / 0.7535 GB, free: 143.3 MB / 0.5606 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 7 * Number of states: 4 (revolute.phi,revolute.w,rotor1D.phi,rotor1D.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 (104): * Single equations (assignments): 100 * Array equations: 3 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 1 system {(1,12,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of Backend phase and start with SimCode phase: time 0.007321/1.115, allocations: 5.766 MB / 0.7591 GB, free: 137.7 MB / 0.5606 GB Notification: Performance of simCode: created initialization part: time 0.00636/1.121, allocations: 4.455 MB / 0.7635 GB, free: 133.3 MB / 0.5606 GB Notification: Performance of simCode: created event and clocks part: time 7.754e-06/1.121, allocations: 3.938 kB / 0.7635 GB, free: 133.3 MB / 0.5606 GB Notification: Performance of simCode: created simulation system equations: time 0.00164/1.123, allocations: 1.28 MB / 0.7647 GB, free: 132 MB / 0.5606 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002722/1.125, allocations: 427.4 kB / 0.7651 GB, free: 131.6 MB / 0.5606 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.05941/1.185, allocations: 42.9 MB / 0.807 GB, free: 83.39 MB / 0.5606 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003959/1.189, allocations: 3.053 MB / 0.81 GB, free: 80.31 MB / 0.5606 GB Notification: Performance of simCode: alias equations: time 0.003754/1.192, allocations: 1.782 MB / 0.8118 GB, free: 78.53 MB / 0.5606 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002679/1.195, allocations: 1.749 MB / 0.8135 GB, free: 76.78 MB / 0.5606 GB Notification: Performance of SimCode: time 2.425e-06/1.195, allocations: 0 / 0.8135 GB, free: 76.78 MB / 0.5606 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.112/1.307, allocations: 64.85 MB / 0.8768 GB, free: 12.22 MB / 0.5606 GB Notification: Performance of buildModelFMU: Generate platform static: time 23.11/24.42, allocations: 2.953 kB / 0.8768 GB, free: 12.22 MB / 0.5606 GB " [Timeout remaining time 635] (rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Rotor1D.Rotor1D_2.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Rotor1D.Rotor1D_2.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Rotor1D.Rotor1D_2.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Rotor1D.Rotor1D_2.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Rotor1D.Rotor1D_2_res.mat --tempDir=temp_ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Parts_Rotor1D_Rotor1D_2_fmu --startTime=0 --stopTime=3 --stepSize=0.00059976 --timeout=50 --tolerance=1e-06 ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_Parts_Rotor1D_Rotor1D_2.fmu > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Rotor1D.Rotor1D_2.pipe 2>&1) [Timeout 52.5] [Calling os._exit(0), Time elapsed: 27.512616569176316] Failed to read output from testmodel.py, exit status != 0: ['time', 'revolute.phi', 'revolute.w', 'rotor1D.phi', 'rotor1D.w'] 24.55146374600008 24.575410329 24.098451984 Calling exit ...