Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.PlanarLoopWithMove.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.001748/0.001748, allocations: 118.7 kB / 18.5 MB, free: 4.602 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.002127/0.002127, allocations: 210.5 kB / 21.46 MB, free: 1.648 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.654/1.654, allocations: 230.2 MB / 254.5 MB, free: 15.26 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.2457/0.2457, allocations: 46.89 MB / 357.4 MB, free: 10.52 MB / 286.1 MB
"
[Timeout remaining time 180]
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.PlanarLoopWithMove,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_PlanarLoopWithMove",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.MultiBody.PlanarLoopWithMove,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_PlanarLoopWithMove",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.002267/0.002267, allocations: 83.86 kB / 0.4912 GB, free: 8.59 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1385/0.1408, allocations: 65.99 MB / 0.5556 GB, free: 6.473 MB / 414.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.PlanarLoopWithMove): time 0.01395/0.1547, allocations: 12.02 MB / 0.5674 GB, free: 10.39 MB / 430.1 MB
Notification: Performance of NFInst.instExpressions: time 0.009697/0.1644, allocations: 4.777 MB / 0.572 GB, free: 5.594 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002574/0.167, allocations: 83.75 kB / 0.5721 GB, free: 5.512 MB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.006219/0.1732, allocations: 3.013 MB / 0.5751 GB, free: 2.488 MB / 430.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.006167/0.1794, allocations: 2.026 MB / 0.577 GB, free: 468 kB / 430.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002517/0.1819, allocations: 0.8537 MB / 0.5779 GB, free: 15.6 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007121/0.189, allocations: 4.093 MB / 0.5819 GB, free: 11.5 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004267/0.1933, allocations: 2.856 MB / 0.5847 GB, free: 8.59 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003709/0.197, allocations: 1.752 MB / 0.5864 GB, free: 6.832 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004128/0.2011, allocations: 2.367 MB / 0.5887 GB, free: 4.457 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.000941/0.2021, allocations: 308 kB / 0.589 GB, free: 4.156 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002648/0.2047, allocations: 1.229 MB / 0.5902 GB, free: 2.926 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.002295/0.207, allocations: 2.029 MB / 0.5922 GB, free: 0.8906 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.3307/0.5378, allocations: 2.273 MB / 0.5944 GB, free: 9.836 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01169/0.5495, allocations: 7.168 MB / 0.6014 GB, free: 9.16 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 6.953e-06/0.5495, allocations: 4.391 kB / 0.6014 GB, free: 9.16 MB / 446.1 MB
Notification: Performance of FrontEnd: time 1.513e-06/0.5495, allocations: 0 / 0.6014 GB, free: 9.16 MB / 446.1 MB
Notification: Performance of Transformations before backend: time 0.0003864/0.5498, allocations: 0 / 0.6014 GB, free: 9.16 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: 1597
 * Number of variables: 1597
Notification: Performance of Generate backend data structure: time 0.02007/0.5699, allocations: 5.489 MB / 0.6068 GB, free: 6.891 MB / 446.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.97e-05/0.57, allocations: 10.22 kB / 0.6068 GB, free: 6.891 MB / 446.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.00237/0.5723, allocations: 0.7467 MB / 0.6075 GB, free: 6.812 MB / 446.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007533/0.5799, allocations: 1.91 MB / 0.6094 GB, free: 6.477 MB / 446.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.008105/0.588, allocations: 2.787 MB / 0.6121 GB, free: 5.816 MB / 446.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002737/0.5882, allocations: 241.8 kB / 0.6123 GB, free: 5.809 MB / 446.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001589/0.5898, allocations: 313.7 kB / 0.6126 GB, free: 5.805 MB / 446.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02088/0.6107, allocations: 11.2 MB / 0.6235 GB, free: 1.32 MB / 446.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001311/0.6108, allocations: 47.09 kB / 0.6236 GB, free: 1.312 MB / 446.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005031/0.6114, allocations: 152.3 kB / 0.6237 GB, free: 1.25 MB / 446.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.003588/0.6149, allocations: 2.298 MB / 0.626 GB, free: 0.8789 MB / 446.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01956/0.6345, allocations: 9.863 MB / 0.6356 GB, free: 12.56 MB / 462.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.06611/0.7006, allocations: 44.19 MB / 0.6788 GB, free: 0 / 494.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.01396/0.7146, allocations: 5.6 MB / 0.6842 GB, free: 10.27 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004395/0.719, allocations: 2.914 MB / 0.6871 GB, free: 7.344 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01704/0.736, allocations: 9.366 MB / 0.6962 GB, free: 13.72 MB / 0.5137 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0113/0.7473, allocations: 3.372 MB / 0.6995 GB, free: 10.33 MB / 0.5137 GB
Notification: Performance of pre-optimization done (n=211): time 4.769e-06/0.7473, allocations: 0 / 0.6995 GB, free: 10.33 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=285): time 0.1251/0.8724, allocations: 33.62 MB / 0.7324 GB, free: 8.832 MB / 0.545 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001213/0.8725, allocations: 158.5 kB / 0.7325 GB, free: 8.648 MB / 0.545 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00818/0.8807, allocations: 4.203 MB / 0.7366 GB, free: 4.414 MB / 0.545 GB
Notification: Performance of collectPreVariables (initialization): time 0.00093/0.8816, allocations: 65.7 kB / 0.7367 GB, free: 4.344 MB / 0.545 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005009/0.8867, allocations: 3.38 MB / 0.74 GB, free: 0.9766 MB / 0.545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002501/0.8892, allocations: 1.099 MB / 0.741 GB, free: 15.9 MB / 0.5606 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002971/0.8921, allocations: 1.342 MB / 0.7424 GB, free: 14.55 MB / 0.5606 GB
Notification: Performance of setup shared object (initialization): time 0.0001713/0.8923, allocations: 305.1 kB / 0.7426 GB, free: 14.25 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005967/0.8983, allocations: 3.374 MB / 0.7459 GB, free: 10.87 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.009421/0.9077, allocations: 6.969 MB / 0.7527 GB, free: 2.199 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01647/0.9242, allocations: 11.17 MB / 0.7637 GB, free: 5.793 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001257/0.9243, allocations: 36 kB / 0.7637 GB, free: 5.758 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=859) (initialization): time 0.02903/0.9533, allocations: 12.57 MB / 0.776 GB, free: 9.453 MB / 0.5919 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002125/0.9535, allocations: 63.94 kB / 0.776 GB, free: 9.391 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002532/0.9538, allocations: 124 kB / 0.7761 GB, free: 9.27 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008027/0.9618, allocations: 2.638 MB / 0.7787 GB, free: 6.621 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006429/0.9682, allocations: 1.474 MB / 0.7801 GB, free: 5.145 MB / 0.5919 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03472/1.003, allocations: 23.41 MB / 0.803 GB, free: 13.21 MB / 0.6231 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006013/1.009, allocations: 431.4 kB / 0.8034 GB, free: 12.79 MB / 0.6231 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001677/1.011, allocations: 394.7 kB / 0.8038 GB, free: 12.41 MB / 0.6231 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 571
 * Number of states: 0 ()
 * Number of discrete variables: 47 ($PRE.combiTimeTable.nextTimeEvent,$whenCondition1,combiTimeTable.nextTimeEventScaled,$PRE.combiTimeTable.nextTimeEventScaled,combiTimeTable.nextTimeEvent,rod3.color[3],rod3.color[2],rod3.color[1],bodyShape.color[3],bodyShape.color[2],bodyShape.color[1],bodyShape.body.sphereColor[3],bodyShape.body.sphereColor[2],bodyShape.body.sphereColor[1],bodyShape.frameTranslation.color[3],bodyShape.frameTranslation.color[2],bodyShape.frameTranslation.color[1],rod2.color[3],rod2.color[2],rod2.color[1],rod1.color[3],rod1.color[2],rod1.color[1],r4.cylinderColor[3],r4.cylinderColor[2],r4.cylinderColor[1],r3.cylinderColor[3],r3.cylinderColor[2],r3.cylinderColor[1],r2.cylinderColor[3],r2.cylinderColor[2],r2.cylinderColor[1],r1.cylinderColor[3],r1.cylinderColor[2],r1.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 (760):
 * Single equations (assignments): 753
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 3 systems
   {(2,16,100.0%), (2,14,100.0%), (2,14,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(2,27)}
Notification: Performance of prepare postOptimizeDAE: time 0.006018/1.017, allocations: 2.225 MB / 0.806 GB, free: 10.17 MB / 0.6231 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001327/1.018, allocations: 425.1 kB / 0.8064 GB, free: 9.754 MB / 0.6231 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01716/1.035, allocations: 7.969 MB / 0.8142 GB, free: 1.746 MB / 0.6231 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.821e-05/1.035, allocations: 31.94 kB / 0.8142 GB, free: 1.715 MB / 0.6231 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.975e-05/1.035, allocations: 23.98 kB / 0.8142 GB, free: 1.691 MB / 0.6231 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.542e-05/1.035, allocations: 15.94 kB / 0.8142 GB, free: 1.676 MB / 0.6231 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.03569/1.071, allocations: 14.56 MB / 0.8284 GB, free: 3.082 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.555e-05/1.071, allocations: 4 kB / 0.8284 GB, free: 3.078 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002347/1.073, allocations: 399.3 kB / 0.8288 GB, free: 2.688 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.005917/1.079, allocations: 2.306 MB / 0.8311 GB, free: 380 kB / 0.6387 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0005908/1.08, allocations: 48 kB / 0.8311 GB, free: 332 kB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.3286/1.408, allocations: 23.14 MB / 0.8537 GB, free: 211.4 MB / 0.6387 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.16e-06/1.409, allocations: 6.125 kB / 0.8537 GB, free: 211.4 MB / 0.6387 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01298/1.421, allocations: 8.115 MB / 0.8617 GB, free: 208.6 MB / 0.6387 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00122/1.423, allocations: 456.7 kB / 0.8621 GB, free: 208.5 MB / 0.6387 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0009532/1.424, allocations: 45.31 kB / 0.8621 GB, free: 208.4 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002096/1.426, allocations: 228.4 kB / 0.8623 GB, free: 208.4 MB / 0.6387 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0007217/1.426, allocations: 187.9 kB / 0.8625 GB, free: 208.4 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002263/1.427, allocations: 76.11 kB / 0.8626 GB, free: 208.3 MB / 0.6387 GB
Notification: Performance of sorting global known variables: time 0.003761/1.43, allocations: 2.632 MB / 0.8652 GB, free: 207.4 MB / 0.6387 GB
Notification: Performance of sort global known variables: time 8.1e-08/1.43, allocations: 0 / 0.8652 GB, free: 207.4 MB / 0.6387 GB
Notification: Performance of remove unused functions: time 0.006411/1.437, allocations: 1.339 MB / 0.8665 GB, free: 207.3 MB / 0.6387 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 10
 * Number of states: 0 ()
 * Number of discrete variables: 3 ($whenCondition1,combiTimeTable.nextTimeEvent,combiTimeTable.nextTimeEventScaled)
 * Number of discrete states: 2 (combiTimeTable.nextTimeEvent,combiTimeTable.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (188):
 * Single equations (assignments): 179
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 2
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 3 systems
   {(2,16,100.0%), (3,13,88.9%), (3,13,88.9%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(2,31)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01388/1.451, allocations: 9.091 MB / 0.8754 GB, free: 203.1 MB / 0.6387 GB
Notification: Performance of simCode: created initialization part: time 0.01214/1.463, allocations: 8.512 MB / 0.8837 GB, free: 194.6 MB / 0.6387 GB
Notification: Performance of simCode: created event and clocks part: time 7.404e-06/1.463, allocations: 0 / 0.8837 GB, free: 194.6 MB / 0.6387 GB
Notification: Performance of simCode: created simulation system equations: time 0.005344/1.468, allocations: 3.788 MB / 0.8874 GB, free: 190.7 MB / 0.6387 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003003/1.471, allocations: 0.4947 MB / 0.8879 GB, free: 190.3 MB / 0.6387 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.08076/1.552, allocations: 60.25 MB / 0.9467 GB, free: 124.2 MB / 0.6387 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003454/1.555, allocations: 3.57 MB / 0.9502 GB, free: 120.6 MB / 0.6387 GB
Notification: Performance of simCode: alias equations: time 0.004474/1.56, allocations: 2.14 MB / 0.9523 GB, free: 118.5 MB / 0.6387 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002817/1.563, allocations: 2.081 MB / 0.9543 GB, free: 116.4 MB / 0.6387 GB
Notification: Performance of SimCode: time 1.132e-06/1.563, allocations: 0 / 0.9543 GB, free: 116.4 MB / 0.6387 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1518/1.715, allocations: 101.1 MB / 1.053 GB, free: 15.64 MB / 0.6387 GB
Notification: Performance of buildModelFMU: Generate platform static: time 22.09/23.81, allocations: 14.03 kB / 1.053 GB, free: 15.63 MB / 0.6387 GB
"
[Timeout remaining time 636]
(rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.PlanarLoopWithMove.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.PlanarLoopWithMove.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.PlanarLoopWithMove.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.PlanarLoopWithMove.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.PlanarLoopWithMove_res.mat --tempDir=temp_ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_PlanarLoopWithMove_fmu --startTime=0 --stopTime=3 --stepSize=0.00059976 --timeout=50 --tolerance=1e-06 ModelicaTest_4_1_0-beta_om_ModelicaTest_MultiBody_PlanarLoopWithMove.fmu > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.PlanarLoopWithMove.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 27.228805807884783]
Failed to read output from testmodel.py, exit status != 0:
['time', 'rh1[1]', 'rh1[2]', 'rh1[3]', 'rv1[1]', 'rv1[2]', 'rv1[3]', 'rv2[1]', 'rv2[2]', 'rv2[3]', 'rh2[1]', 'rh2[2]', 'rh2[3]', 'r1.frame_b.r_0[1]', 'r1.frame_b.r_0[2]', 'r1.frame_b.r_0[3]', 'r1.frame_b.f[1]', 'r1.frame_b.f[2]', 'r1.frame_b.f[3]', 'r1.frame_b.t[1]', 'r1.frame_b.t[2]', 'r1.frame_b.t[3]', 'rod1.frame_b.r_0[1]', 'rod1.frame_b.r_0[2]', 'rod1.frame_b.r_0[3]', 'rod1.frame_b.f[1]', 'rod1.frame_b.f[2]', 'rod1.frame_b.f[3]', 'rod1.frame_b.t[1]', 'rod1.frame_b.t[2]', 'rod1.frame_b.t[3]', 'rod2.frame_b.r_0[1]', 'rod2.frame_b.r_0[2]', 'rod2.frame_b.r_0[3]', 'rod2.frame_b.f[1]', 'rod2.frame_b.f[2]', 'rod2.frame_b.f[3]', 'rod2.frame_b.t[1]', 'rod2.frame_b.t[2]', 'rod2.frame_b.t[3]', 'r2.frame_b.r_0[1]', 'r2.frame_b.r_0[2]', 'r2.frame_b.r_0[3]', 'r2.frame_b.f[1]', 'r2.frame_b.f[2]', 'r2.frame_b.f[3]', 'r2.frame_b.t[1]', 'r2.frame_b.t[2]', 'r2.frame_b.t[3]', 'bodyShape.frame_b.r_0[1]', 'bodyShape.frame_b.r_0[2]', 'bodyShape.frame_b.r_0[3]', 'bodyShape.frame_b.f[1]', 'bodyShape.frame_b.f[2]', 'bodyShape.frame_b.f[3]', 'bodyShape.frame_b.t[1]', 'bodyShape.frame_b.t[2]', 'bodyShape.frame_b.t[3]', 'bodyShape.frameTranslation.frame_b.r_0[1]', 'bodyShape.frameTranslation.frame_b.r_0[2]', 'bodyShape.frameTranslation.frame_b.r_0[3]', 'bodyShape.frameTranslation.frame_b.f[1]', 'bodyShape.frameTranslation.frame_b.f[2]', 'bodyShape.frameTranslation.frame_b.f[3]', 'bodyShape.frameTranslation.frame_b.t[1]', 'bodyShape.frameTranslation.frame_b.t[2]', 'bodyShape.frameTranslation.frame_b.t[3]', 'r3.frame_b.r_0[1]', 'r3.frame_b.r_0[2]', 'r3.frame_b.r_0[3]', 'r3.frame_b.f[1]', 'r3.frame_b.f[2]', 'r3.frame_b.f[3]', 'r3.frame_b.t[1]', 'r3.frame_b.t[2]', 'r3.frame_b.t[3]', 'r4.frame_b.r_0[1]', 'r4.frame_b.r_0[2]', 'r4.frame_b.r_0[3]', 'r4.frame_b.f[1]', 'r4.frame_b.f[2]', 'r4.frame_b.f[3]', 'r4.frame_b.t[1]', 'r4.frame_b.t[2]', 'r4.frame_b.t[3]', 'rod3.frame_b.r_0[1]', 'rod3.frame_b.r_0[2]', 'rod3.frame_b.r_0[3]', 'rod3.frame_b.f[1]', 'rod3.frame_b.f[2]', 'rod3.frame_b.f[3]', 'rod3.frame_b.t[1]', 'rod3.frame_b.t[2]', 'rod3.frame_b.t[3]', 'deg2rad1.y[1]', 'deg2rad1.y[2]', 'deg2rad1.y[3]', 'combiTimeTable.y[1]', 'combiTimeTable.y[2]', 'combiTimeTable.y[3]']
24.00841306708753 24.019354324 23.467479758
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f5630e3e020>