Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0_Modelica.Mechanics.MultiBody.Examples.Elementary.PointGravityWithPointMasses.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001677/0.001677, allocations: 103.6 kB / 21.25 MB, free: 0.5664 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.002085/0.002085, allocations: 211 kB / 24.55 MB, free: 3.824 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.643/1.643, allocations: 230.7 MB / 258.3 MB, free: 7.742 MB / 206.1 MB " [Timeout remaining time 178] Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: translateModel(Modelica.Mechanics.MultiBody.Examples.Elementary.PointGravityWithPointMasses,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|body1.r_0.1.|body1.r_0.2.|body1.r_0.3.|body1.v_0.1.|body1.v_0.2.|body1.v_0.3.|body2.r_0.1.|body2.r_0.2.|body2.r_0.3.|body2.v_0.1.|body2.v_0.2.|body2.v_0.3.|body3.r_0.1.|body3.r_0.2.|body3.r_0.3.|body3.v_0.1.|body3.v_0.2.|body3.v_0.3.|body4.r_0.1.|body4.r_0.2.|body4.r_0.3.|body4.v_0.1.|body4.v_0.2.|body4.v_0.3.",fileNamePrefix="Modelica_4.1.0_Modelica.Mechanics.MultiBody.Examples.Elementary.PointGravityWithPointMasses") translateModel(Modelica.Mechanics.MultiBody.Examples.Elementary.PointGravityWithPointMasses,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|body1.r_0.1.|body1.r_0.2.|body1.r_0.3.|body1.v_0.1.|body1.v_0.2.|body1.v_0.3.|body2.r_0.1.|body2.r_0.2.|body2.r_0.3.|body2.v_0.1.|body2.v_0.2.|body2.v_0.3.|body3.r_0.1.|body3.r_0.2.|body3.r_0.3.|body3.v_0.1.|body3.v_0.2.|body3.v_0.3.|body4.r_0.1.|body4.r_0.2.|body4.r_0.3.|body4.v_0.1.|body4.v_0.2.|body4.v_0.3.",fileNamePrefix="Modelica_4.1.0_Modelica.Mechanics.MultiBody.Examples.Elementary.PointGravityWithPointMasses") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.597e-05/2.597e-05, allocations: 2.281 kB / 379.1 MB, free: 2.449 MB / 302.1 MB Notification: Performance of NFInst.instantiate(Modelica.Mechanics.MultiBody.Examples.Elementary.PointGravityWithPointMasses): time 0.3072/0.3073, allocations: 7.019 MB / 386.1 MB, free: 11.04 MB / 302.1 MB Notification: Performance of NFInst.instExpressions: time 0.008913/0.3162, allocations: 2.444 MB / 388.5 MB, free: 9.949 MB / 302.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.002322/0.3185, allocations: 38.09 kB / 388.6 MB, free: 9.941 MB / 302.1 MB Notification: Performance of NFTyping.typeComponents: time 0.003942/0.3224, allocations: 1.407 MB / 390 MB, free: 9.344 MB / 302.1 MB Notification: Performance of NFTyping.typeBindings: time 0.004727/0.3272, allocations: 1.018 MB / 391 MB, free: 8.863 MB / 302.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.001146/0.3283, allocations: 262.4 kB / 391.2 MB, free: 8.73 MB / 302.1 MB Notification: Performance of NFFlatten.flatten: time 0.005664/0.334, allocations: 2.29 MB / 393.5 MB, free: 7.805 MB / 302.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.001853/0.3358, allocations: 0.8118 MB / 394.3 MB, free: 7.414 MB / 302.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.00187/0.3377, allocations: 0.7401 MB / 395.1 MB, free: 7.094 MB / 302.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.002307/0.34, allocations: 1.092 MB / 396.2 MB, free: 6.715 MB / 302.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0002682/0.3403, allocations: 72.41 kB / 396.2 MB, free: 6.711 MB / 302.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.001521/0.3418, allocations: 409.7 kB / 396.6 MB, free: 6.605 MB / 302.1 MB Notification: Performance of combineBinaries: time 0.003405/0.3452, allocations: 3.058 MB / 399.7 MB, free: 4.668 MB / 302.1 MB Notification: Performance of replaceArrayConstructors: time 0.00215/0.3473, allocations: 2.016 MB / 401.7 MB, free: 3.246 MB / 302.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0003847/0.3477, allocations: 78.28 kB / 401.8 MB, free: 3.242 MB / 302.1 MB Notification: Performance of FrontEnd: time 0.0004097/0.3481, allocations: 67.97 kB / 401.9 MB, free: 3.199 MB / 302.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1113 (309) * Number of variables: 1113 (332) Notification: Performance of [SIM] Bindings: time 0.01181/0.36, allocations: 8.015 MB / 409.9 MB, free: 13.56 MB / 318.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.001277/0.3612, allocations: 0.7651 MB / 410.6 MB, free: 12.9 MB / 318.1 MB Notification: Performance of [SIM] Early Inline: time 7.2/7.562, allocations: 1.899 GB / 2.3 GB, free: 11.66 MB / 0.6387 GB Notification: Performance of [SIM] Simplify 1: time 4.387/11.95, allocations: 1.111 GB / 3.411 GB, free: 46.15 MB / 0.8419 GB Notification: Performance of [SIM] Alias: time 1.963/13.91, allocations: 459.3 MB / 3.859 GB, free: 145.6 MB / 0.8419 GB Notification: Performance of [SIM] Simplify 2: time 4.368/18.28, allocations: 1.111 GB / 4.97 GB, free: 88.65 MB / 0.8419 GB Notification: Performance of [SIM] Remove Stream: time 0.2153/18.49, allocations: 68.6 MB / 5.037 GB, free: 84.74 MB / 0.8419 GB Notification: Performance of [SIM] Detect States: time 1.014/19.51, allocations: 197.9 MB / 5.23 GB, free: 270.7 MB / 0.8419 GB Notification: Performance of [SIM] Events: time 1.359/20.87, allocations: 0.5527 GB / 5.783 GB, free: 84.86 MB / 0.8419 GB Notification: Performance of [SIM] Partitioning: time 0.08848/20.96, allocations: 36.08 MB / 5.818 GB, free: 69.24 MB / 0.8419 GB Notification: Performance of [SIM] Causalize: time 0.3796/21.34, allocations: 30.13 MB / 5.848 GB, free: 485.9 MB / 0.8419 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.1937/21.53, allocations: 115.4 MB / 5.96 GB, free: 435.6 MB / 0.8419 GB Notification: Performance of [INI] Simplify: time 0.08336/21.61, allocations: 50.12 MB / 6.009 GB, free: 387.3 MB / 0.8419 GB Notification: Performance of [INI] Inline: time 0.1858/21.8, allocations: 135.7 MB / 6.142 GB, free: 251.6 MB / 0.8419 GB Notification: Performance of [INI] Partitioning: time 0.0009802/21.8, allocations: 151.1 kB / 6.142 GB, free: 251.4 MB / 0.8419 GB Notification: Performance of [INI] Cleanup: time 0.05188/21.85, allocations: 18.64 MB / 6.16 GB, free: 232.8 MB / 0.8419 GB Notification: Performance of [INI] Causalize: time 0.09207/21.94, allocations: 30.1 MB / 6.19 GB, free: 202.6 MB / 0.8419 GB Notification: Performance of [INI] Tearing: time 0.0002447/21.94, allocations: 312.1 kB / 6.19 GB, free: 202.3 MB / 0.8419 GB Notification: Performance of [SIM] Initialization: time 2.034e-06/21.94, allocations: 0 / 6.19 GB, free: 202.3 MB / 0.8419 GB Notification: Performance of [SIM] DAE-Mode: time 0.003267/21.95, allocations: 1.817 MB / 6.192 GB, free: 199.7 MB / 0.8419 GB Notification: Performance of [SIM] Remove Dummies: time 5.981e-05/21.95, allocations: 32.11 kB / 6.192 GB, free: 199.7 MB / 0.8419 GB Notification: Performance of [SIM] Tearing: time 0.0003246/21.95, allocations: 0.5731 MB / 6.192 GB, free: 199.1 MB / 0.8419 GB Notification: Performance of [SIM] Categorize: time 0.0001867/21.95, allocations: 45.05 kB / 6.192 GB, free: 199.1 MB / 0.8419 GB Notification: Performance of [SIM] Solve: time 0.668/22.62, allocations: 221.7 MB / 6.409 GB, free: 394.8 MB / 0.8419 GB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref spring.lineForce.frame_b.R.T[1, 1] is neither a seed nor a partial candidate! " [Timeout remaining time 637] [Calling sys.exit(0), Time elapsed: 25.19673084601527] Failed to read output from testmodel.py, exit status != 0: ['time', 'body1.r_0[1]', 'body1.r_0[2]', 'body1.r_0[3]', 'body1.v_0[1]', 'body1.v_0[2]', 'body1.v_0[3]', 'body2.r_0[1]', 'body2.r_0[2]', 'body2.r_0[3]', 'body2.v_0[1]', 'body2.v_0[2]', 'body2.v_0[3]', 'body3.r_0[1]', 'body3.r_0[2]', 'body3.r_0[3]', 'body3.v_0[1]', 'body3.v_0[2]', 'body3.v_0[3]', 'body4.r_0[1]', 'body4.r_0[2]', 'body4.r_0[3]', 'body4.v_0[1]', 'body4.v_0[2]', 'body4.v_0[3]'] 22.626830632972997 22.637499454 22.286650478 Calling exit ...