Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII.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.0007546/0.0007546, allocations: 72.5 kB / 19.93 MB, free: 4.633 MB / 18.57 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 0.8599/0.8599, allocations: 177.2 MB / 200.2 MB, free: 5.945 MB / 186.7 MB
"
[Timeout remaining time 179]
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.001009/0.001009, allocations: 160.5 kB / 256.7 MB, free: 13.35 MB / 250.7 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0/package.mo): time 0.2544/0.2544, allocations: 80.26 MB / 393.4 MB, free: 2.441 MB / 314.7 MB
"
[Timeout remaining time 179]
Using package OpenIPSL with version 3.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0/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 Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 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(OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII")
translateModel(OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 2.435e-06/2.435e-06, allocations: 0 / 0.5561 GB, free: 12.14 MB / 490.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.674e-05/2.918e-05, allocations: 6.219 kB / 0.5561 GB, free: 12.13 MB / 490.7 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII): time 0.008409/0.008438, allocations: 11.73 MB / 0.5675 GB, free: 360 kB / 490.7 MB
Notification: Performance of NFInst.instExpressions: time 0.004885/0.01332, allocations: 3.445 MB / 0.5709 GB, free: 12.89 MB / 0.4948 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0007974/0.01412, allocations: 28 kB / 0.5709 GB, free: 12.87 MB / 0.4948 GB
Notification: Performance of NFTyping.typeComponents: time 0.0008358/0.01496, allocations: 0.5614 MB / 0.5715 GB, free: 12.3 MB / 0.4948 GB
Notification: Performance of NFTyping.typeBindings: time 0.002128/0.01708, allocations: 1.612 MB / 0.573 GB, free: 10.69 MB / 0.4948 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001882/0.01897, allocations: 1.543 MB / 0.5746 GB, free: 9.164 MB / 0.4948 GB
Notification: Performance of NFFlatten.flatten: time 0.002265/0.02123, allocations: 3.747 MB / 0.5782 GB, free: 5.398 MB / 0.4948 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0005779/0.02181, allocations: 0.5814 MB / 0.5788 GB, free: 4.766 MB / 0.4948 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001486/0.0233, allocations: 2.123 MB / 0.5809 GB, free: 2.637 MB / 0.4948 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001108/0.0244, allocations: 1.554 MB / 0.5824 GB, free: 1.078 MB / 0.4948 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002479/0.02465, allocations: 284 kB / 0.5826 GB, free: 0.8008 MB / 0.4948 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0005027/0.02515, allocations: 447.7 kB / 0.5831 GB, free: 372 kB / 0.4948 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003942/0.02555, allocations: 0.7739 MB / 0.5838 GB, free: 15.59 MB / 0.5105 GB
Notification: Performance of NFVerifyModel.verify: time 0.0006453/0.02619, allocations: 1.078 MB / 0.5849 GB, free: 14.5 MB / 0.5105 GB
Notification: Performance of NFConvertDAE.convert: time 0.00254/0.02873, allocations: 4.088 MB / 0.5889 GB, free: 10.4 MB / 0.5105 GB
Notification: Performance of FrontEnd - DAE generated: time 3.767e-06/0.02874, allocations: 0 / 0.5889 GB, free: 10.4 MB / 0.5105 GB
Notification: Performance of FrontEnd: time 1.473e-06/0.02874, allocations: 4 kB / 0.5889 GB, free: 10.4 MB / 0.5105 GB
Notification: Performance of Transformations before backend: time 2.689e-05/0.02877, allocations: 0 / 0.5889 GB, free: 10.4 MB / 0.5105 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 523
 * Number of variables: 523
Notification: Performance of Generate backend data structure: time 0.0117/0.04046, allocations: 7.335 MB / 0.596 GB, free: 2.957 MB / 0.5105 GB
Notification: Performance of prepare preOptimizeDAE: time 3.982e-05/0.0405, allocations: 8.031 kB / 0.596 GB, free: 2.949 MB / 0.5105 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006934/0.04744, allocations: 2.331 MB / 0.5983 GB, free: 0.6133 MB / 0.5105 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.2208/0.2683, allocations: 1.794 MB / 0.6001 GB, free: 90.86 MB / 0.5105 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004046/0.2687, allocations: 0.8212 MB / 0.6009 GB, free: 90.16 MB / 0.5105 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003681/0.2691, allocations: 219.2 kB / 0.6011 GB, free: 90.16 MB / 0.5105 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003573/0.2726, allocations: 3.085 MB / 0.6041 GB, free: 89.19 MB / 0.5105 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.015e-05/0.2727, allocations: 0 / 0.6041 GB, free: 89.19 MB / 0.5105 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001645/0.2728, allocations: 82.16 kB / 0.6042 GB, free: 89.13 MB / 0.5105 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.202e-05/0.2728, allocations: 47.91 kB / 0.6042 GB, free: 89.13 MB / 0.5105 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003225/0.2761, allocations: 2.831 MB / 0.607 GB, free: 88.13 MB / 0.5105 GB
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.00975/0.2858, allocations: 7.43 MB / 0.6142 GB, free: 84.64 MB / 0.5105 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006012/0.2918, allocations: 3.575 MB / 0.6177 GB, free: 83.66 MB / 0.5105 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002369/0.2942, allocations: 1.82 MB / 0.6195 GB, free: 82.94 MB / 0.5105 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001827/0.2944, allocations: 37.67 kB / 0.6195 GB, free: 82.94 MB / 0.5105 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002937/0.2973, allocations: 2.29 MB / 0.6218 GB, free: 82.09 MB / 0.5105 GB
Notification: Performance of pre-optimization done (n=248): time 4.057e-06/0.2973, allocations: 0 / 0.6218 GB, free: 82.09 MB / 0.5105 GB
Notification: Performance of matching and sorting (n=248): time 0.06029/0.3576, allocations: 27.97 MB / 0.6491 GB, free: 67.59 MB / 0.5105 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.253e-05/0.3577, allocations: 180.2 kB / 0.6493 GB, free: 67.37 MB / 0.5105 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002107/0.3598, allocations: 2.246 MB / 0.6515 GB, free: 65.13 MB / 0.5105 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001923/0.36, allocations: 71.58 kB / 0.6515 GB, free: 65.06 MB / 0.5105 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004105/0.3604, allocations: 1.191 MB / 0.6527 GB, free: 63.95 MB / 0.5105 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0005258/0.3609, allocations: 0.9021 MB / 0.6536 GB, free: 63.15 MB / 0.5105 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006308/0.3616, allocations: 0.5499 MB / 0.6541 GB, free: 62.59 MB / 0.5105 GB
Notification: Performance of setup shared object (initialization): time 2.575e-05/0.3616, allocations: 301.1 kB / 0.6544 GB, free: 62.29 MB / 0.5105 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002293/0.3639, allocations: 2.043 MB / 0.6564 GB, free: 60.22 MB / 0.5105 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002379/0.3663, allocations: 2.411 MB / 0.6587 GB, free: 57.7 MB / 0.5105 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02572/0.392, allocations: 14.29 MB / 0.6727 GB, free: 43.2 MB / 0.5105 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.245e-05/0.392, allocations: 4 kB / 0.6727 GB, free: 43.19 MB / 0.5105 GB
Notification: Performance of matching and sorting (n=407) (initialization): time 0.02004/0.412, allocations: 12.5 MB / 0.6849 GB, free: 30.61 MB / 0.5105 GB
Notification: Performance of prepare postOptimizeDAE: time 5.211e-05/0.4121, allocations: 110.8 kB / 0.685 GB, free: 30.47 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.556e-05/0.4121, allocations: 12 kB / 0.685 GB, free: 30.46 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008504/0.4206, allocations: 5.241 MB / 0.6901 GB, free: 25.21 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001526/0.4221, allocations: 0.5539 MB / 0.6907 GB, free: 24.66 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03031/0.4524, allocations: 22.49 MB / 0.7127 GB, free: 2.055 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002623/0.4551, allocations: 493.8 kB / 0.7131 GB, free: 1.57 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001618/0.4552, allocations: 116 kB / 0.7132 GB, free: 1.457 MB / 0.5105 GB
Warning: Assuming fixed start value for the following 7 variables:
         order3_2.delta:VARIABLE(flow=false start = order3_2.delta0 unit = \"rad\" fixed = true )  \"Rotor angle\" type: Real
         order3_2.w:VARIABLE(flow=false start = 1.0 fixed = true )  \"Rotor speed [pu]\" type: Real
         order3_2.e1q:VARIABLE(start = order3_2.e1q0 unit = \"1\" fixed = true )  \"q-axis transient voltage\" type: Real
         order2.delta:VARIABLE(flow=false start = order2.delta0 unit = \"rad\" fixed = true )  \"Rotor angle\" type: Real
         order2.w:VARIABLE(flow=false start = 1.0 fixed = true )  \"Rotor speed [pu]\" type: Real
         order4_1.delta:VARIABLE(flow=false start = order4_1.delta0 unit = \"rad\" fixed = true )  \"Rotor angle\" type: Real
         order4_1.w:VARIABLE(flow=false start = 1.0 fixed = true )  \"Rotor speed [pu]\" type: Real
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 29
 * Number of states: 0 ()
 * Number of discrete variables: 4 ($whenCondition2,$whenCondition1,$whenCondition4,$whenCondition3)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (320):
 * Single equations (assignments): 315
 * Array equations: 0
 * Algorithm blocks: 4
 * 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
   {(63,25,8.1%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0009615/0.4562, allocations: 0.5302 MB / 0.7138 GB, free: 0.9102 MB / 0.5105 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002975/0.4565, allocations: 310 kB / 0.714 GB, free: 0.6055 MB / 0.5105 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02151/0.478, allocations: 11.86 MB / 0.7256 GB, free: 4.676 MB / 0.5261 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.486e-05/0.478, allocations: 28 kB / 0.7257 GB, free: 4.648 MB / 0.5261 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.78e-05/0.478, allocations: 20 kB / 0.7257 GB, free: 4.629 MB / 0.5261 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.463e-05/0.4781, allocations: 15.95 kB / 0.7257 GB, free: 4.613 MB / 0.5261 GB
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 postOpt removeSimpleEquations (simulation): time 0.02455/0.5026, allocations: 14.21 MB / 0.7396 GB, free: 6.359 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.963e-06/0.5026, allocations: 0 / 0.7396 GB, free: 6.359 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0007347/0.5034, allocations: 255.6 kB / 0.7398 GB, free: 6.109 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.009047/0.5124, allocations: 5.235 MB / 0.7449 GB, free: 0.8594 MB / 0.5417 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001678/0.5126, allocations: 51.98 kB / 0.745 GB, free: 0.8086 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03407/0.5466, allocations: 23.99 MB / 0.7684 GB, free: 8.527 MB / 0.573 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.224e-06/0.5466, allocations: 4 kB / 0.7684 GB, free: 8.523 MB / 0.573 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02616/0.5728, allocations: 14.3 MB / 0.7824 GB, free: 10.08 MB / 0.5886 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001065/0.5739, allocations: 345.4 kB / 0.7827 GB, free: 9.742 MB / 0.5886 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002694/0.5741, allocations: 47.94 kB / 0.7828 GB, free: 9.695 MB / 0.5886 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001573/0.5757, allocations: 299.6 kB / 0.783 GB, free: 9.402 MB / 0.5886 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001759/0.5775, allocations: 0.6034 MB / 0.7836 GB, free: 8.797 MB / 0.5886 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001389/0.5776, allocations: 63.98 kB / 0.7837 GB, free: 8.734 MB / 0.5886 GB
Notification: Performance of sorting global known variables: time 0.001641/0.5792, allocations: 1.479 MB / 0.7851 GB, free: 7.25 MB / 0.5886 GB
Notification: Performance of sort global known variables: time 7e-08/0.5792, allocations: 0 / 0.7851 GB, free: 7.25 MB / 0.5886 GB
Notification: Performance of remove unused functions: time 0.002391/0.5816, allocations: 1.182 MB / 0.7863 GB, free: 6.066 MB / 0.5886 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 17 (order3_2.delta,order3_2.w,order3_2.e1q,order2.delta,order2.w,order4_1.delta,order4_1.w,order4_1.e1q,order4_1.e1d,Exc1.ExcitationSystem.x_scaled[1],Exc1.derivativeBlock.x,Exc1.firstOrder2.y,Exc1.simpleLagLim.state,Exc2.ExcitationSystem.x_scaled[1],Exc2.derivativeBlock.x,Exc2.firstOrder2.y,Exc2.simpleLagLim.state)
 * Number of discrete variables: 4 ($whenCondition3,$whenCondition4,$whenCondition1,$whenCondition2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (157):
 * Single equations (assignments): 152
 * Array equations: 0
 * Algorithm blocks: 2
 * 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): 1 system
   {(65,23,7.8%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,6), (1,6)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0003888/0.582, allocations: 183.8 kB / 0.7865 GB, free: 5.883 MB / 0.5886 GB
Notification: Performance of simCode: created initialization part: time 0.01026/0.5923, allocations: 6.444 MB / 0.7928 GB, free: 15.34 MB / 0.6042 GB
Notification: Performance of simCode: created event and clocks part: time 3.947e-06/0.5923, allocations: 4.062 kB / 0.7928 GB, free: 15.33 MB / 0.6042 GB
Notification: Performance of simCode: created simulation system equations: time 0.007109/0.5994, allocations: 4.245 MB / 0.7969 GB, free: 11.01 MB / 0.6042 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001512/0.6009, allocations: 270.9 kB / 0.7972 GB, free: 10.75 MB / 0.6042 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.007137/0.608, allocations: 5.353 MB / 0.8024 GB, free: 5.375 MB / 0.6042 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001218/0.6093, allocations: 1.256 MB / 0.8036 GB, free: 4.082 MB / 0.6042 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005259/0.6098, allocations: 188.4 kB / 0.8038 GB, free: 3.898 MB / 0.6042 GB
Notification: Performance of SimCode: time 1.442e-06/0.6098, allocations: 0 / 0.8038 GB, free: 3.898 MB / 0.6042 GB
Notification: Performance of Templates: time 0.2463/0.8561, allocations: 65.66 MB / 0.8679 GB, free: 199.1 MB / 0.6355 GB
"
[Timeout remaining time 659]
make -j1 -f OpenIPSL_OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII.makefile [Timeout 660]
(rm -f OpenIPSL_OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII.pipe ; mkfifo OpenIPSL_OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII.pipe ; head -c 1048576 < OpenIPSL_OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII.pipe >> ../files/OpenIPSL_OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII.sim & ./OpenIPSL_OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_OpenIPSL.Examples.PSATSystems.ThreeArea.FourthOrder_AVRII.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 7.565329651348293]
Failed to read output from testmodel.py, exit status != 0:
0.8619430977851152 0.868787396 0.838750136
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x727de5179b20>