Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr EHPTexamples_latest_EHPTexamples.SHEV.SHEVpowerFilt.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/EHPTlib 3.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/EHPTlib 3.0.0/package.mo): time 0.03015/0.03015, allocations: 6.474 MB / 25.57 MB, free: 3.582 MB / 18.57 MB
"
[Timeout remaining time 180]
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.001033/0.001033, allocations: 83.72 kB / 30.8 MB, free: 4.961 MB / 24.77 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.0009165/0.0009165, allocations: 152.1 kB / 36.13 MB, free: 6.844 MB / 24.77 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.8739/0.8739, allocations: 177.2 MB / 218.5 MB, free: 13.58 MB / 202.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/EHPTexamples main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/EHPTexamples main/package.mo): time 0.008705/0.008705, allocations: 2.5 MB / 279.5 MB, free: 0.5078 MB / 250.7 MB
"
[Timeout remaining time 180]
Using package EHPTexamples with version  (/home/hudson/saved_omc/libraries/.openmodelica/libraries/EHPTexamples main/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 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)
Using package EHPTlib with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/EHPTlib 3.0.0/package.mo)
Running command: "" <> buildModelFMU(EHPTexamples.SHEV.SHEVpowerFilt,fileNamePrefix="EHPTexamples_latest_EHPTexamples_SHEV_SHEVpowerFilt",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(EHPTexamples.SHEV.SHEVpowerFilt,fileNamePrefix="EHPTexamples_latest_EHPTexamples_SHEV_SHEVpowerFilt",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.673e-06/1.673e-06, allocations: 0 / 408.8 MB, free: 14.16 MB / 330.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.435e-05/1.602e-05, allocations: 2.281 kB / 408.8 MB, free: 14.16 MB / 330.7 MB
Notification: Performance of NFInst.instantiate(EHPTexamples.SHEV.SHEVpowerFilt): time 0.008993/0.009009, allocations: 10.76 MB / 419.6 MB, free: 3.34 MB / 330.7 MB
Notification: Performance of NFInst.instExpressions: time 0.1479/0.1569, allocations: 5.481 MB / 425 MB, free: 16.35 MB / 330.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001639/0.1585, allocations: 71.12 kB / 425.1 MB, free: 16.35 MB / 330.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001115/0.1596, allocations: 0.7205 MB / 425.8 MB, free: 16.34 MB / 330.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.001635/0.1613, allocations: 1.105 MB / 426.9 MB, free: 16.21 MB / 330.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002589/0.1639, allocations: 2.21 MB / 429.1 MB, free: 15.8 MB / 330.7 MB
Notification: Performance of NFFlatten.flatten: time 0.002462/0.1663, allocations: 4.249 MB / 433.4 MB, free: 13.56 MB / 330.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001077/0.1674, allocations: 1.098 MB / 434.5 MB, free: 12.93 MB / 330.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.00167/0.1691, allocations: 2.33 MB / 436.8 MB, free: 11.76 MB / 330.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001014/0.1701, allocations: 1.268 MB / 438.1 MB, free: 11.33 MB / 330.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003716/0.1705, allocations: 445.2 kB / 438.5 MB, free: 11.33 MB / 330.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0007145/0.1712, allocations: 0.6703 MB / 439.2 MB, free: 11.27 MB / 330.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0005373/0.1717, allocations: 1.034 MB / 440.2 MB, free: 10.64 MB / 330.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0006857/0.1724, allocations: 1.178 MB / 441.4 MB, free: 10.01 MB / 330.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002719/0.1751, allocations: 5.198 MB / 446.6 MB, free: 6.84 MB / 330.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.689e-06/0.1751, allocations: 0 / 446.6 MB, free: 6.84 MB / 330.7 MB
Notification: Performance of FrontEnd: time 1.853e-06/0.1751, allocations: 0.9375 kB / 446.6 MB, free: 6.84 MB / 330.7 MB
Notification: Performance of Transformations before backend: time 4.14e-05/0.1752, allocations: 4 kB / 446.6 MB, free: 6.836 MB / 330.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 572
 * Number of variables: 572
Notification: Performance of Generate backend data structure: time 0.004125/0.1793, allocations: 3.97 MB / 450.6 MB, free: 3.91 MB / 330.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.373e-05/0.1793, allocations: 13.62 kB / 450.6 MB, free: 3.906 MB / 330.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0002657/0.1796, allocations: 316.4 kB / 450.9 MB, free: 3.664 MB / 330.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0005208/0.1801, allocations: 413.6 kB / 451.3 MB, free: 3.449 MB / 330.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002092/0.1822, allocations: 2.104 MB / 453.4 MB, free: 1.977 MB / 330.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001647/0.1824, allocations: 352.7 kB / 453.8 MB, free: 1.695 MB / 330.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002172/0.1826, allocations: 240.7 kB / 454 MB, free: 1.613 MB / 330.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002808/0.1854, allocations: 3.403 MB / 457.4 MB, free: 14.93 MB / 346.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.102e-05/0.1854, allocations: 16.86 kB / 457.4 MB, free: 14.91 MB / 346.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001521/0.1856, allocations: 98.31 kB / 457.5 MB, free: 14.84 MB / 346.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.28e-05/0.1856, allocations: 54.91 kB / 457.6 MB, free: 14.84 MB / 346.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002445/0.1881, allocations: 1.958 MB / 459.5 MB, free: 13.73 MB / 346.7 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.008066/0.1961, allocations: 8.193 MB / 467.7 MB, free: 5.391 MB / 346.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001921/0.198, allocations: 1.605 MB / 469.3 MB, free: 3.766 MB / 346.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009694/0.199, allocations: 0.8584 MB / 470.2 MB, free: 2.879 MB / 346.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 6.475e-05/0.1991, allocations: 17.31 kB / 470.2 MB, free: 2.859 MB / 346.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.00118/0.2003, allocations: 1.304 MB / 471.5 MB, free: 1.441 MB / 346.7 MB
Notification: Performance of pre-optimization done (n=150): time 2.715e-06/0.2003, allocations: 0 / 471.5 MB, free: 1.441 MB / 346.7 MB
Notification: Performance of matching and sorting (n=160): time 0.00752/0.2078, allocations: 6.287 MB / 477.8 MB, free: 10.97 MB / 362.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000229/0.208, allocations: 0.7798 MB / 478.6 MB, free: 10.01 MB / 362.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002749/0.2108, allocations: 2.976 MB / 481.5 MB, free: 7.023 MB / 362.7 MB
Notification: Performance of collectPreVariables (initialization): time 9.081e-05/0.2109, allocations: 65.7 kB / 481.6 MB, free: 6.953 MB / 362.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0007728/0.2116, allocations: 1.365 MB / 483 MB, free: 5.582 MB / 362.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.000303/0.2119, allocations: 0.5557 MB / 483.5 MB, free: 5.035 MB / 362.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003925/0.2123, allocations: 395.4 kB / 483.9 MB, free: 4.645 MB / 362.7 MB
Notification: Performance of setup shared object (initialization): time 6.773e-05/0.2124, allocations: 305.1 kB / 484.2 MB, free: 4.344 MB / 362.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001012/0.2134, allocations: 0.8469 MB / 485.1 MB, free: 3.469 MB / 362.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001465/0.2149, allocations: 1.936 MB / 487 MB, free: 1.168 MB / 362.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004496/0.2194, allocations: 3.637 MB / 490.6 MB, free: 13.32 MB / 378.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.519e-06/0.2194, allocations: 0 / 490.6 MB, free: 13.32 MB / 378.7 MB
Notification: Performance of matching and sorting (n=253) (initialization): time 0.003087/0.2225, allocations: 2.619 MB / 493.2 MB, free: 10.64 MB / 378.7 MB
Notification: Performance of prepare postOptimizeDAE: time 7.292e-05/0.2225, allocations: 130.8 kB / 493.4 MB, free: 10.49 MB / 378.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.295e-05/0.2225, allocations: 19.88 kB / 493.4 MB, free: 10.47 MB / 378.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000376/0.2229, allocations: 237.7 kB / 493.6 MB, free: 10.23 MB / 378.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008558/0.2238, allocations: 443.3 kB / 494.1 MB, free: 9.801 MB / 378.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001326/0.2251, allocations: 2.141 MB / 496.2 MB, free: 7.516 MB / 378.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008268/0.2259, allocations: 184 kB / 496.4 MB, free: 7.336 MB / 378.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001023/0.226, allocations: 87.98 kB / 496.5 MB, free: 7.25 MB / 378.7 MB
Warning: Assuming fixed start value for the following 6 variables:
         mass.s:VARIABLE(start = 0.0 unit = \"m\" fixed = true )  \"Absolute position of center of component (s = flange_a.s + L/2 = flange_b.s - L/2)\" type: Real
         genset.iceT.wSensor.flange.phi:VARIABLE(flow=false unit = \"rad\" fixed = true )  \"Absolute rotation angle of flange\" type: Real
         mass.v:VARIABLE(start = 0.0 unit = \"m/s\" fixed = true )  \"Absolute velocity of component\" type: Real
         powFilt.y:VARIABLE(flow=false start = powFilt.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         battery.C1.v:VARIABLE(start = 0.0 unit = \"V\" fixed = true )  \"Voltage drop of the two pins (= p.v - n.v)\" type: Real
         battery.cDummy.v:VARIABLE(start = battery.EBatteryMin + battery.SOCInit * (battery.EBatteryMax - battery.EBatteryMin) unit = \"V\" fixed = true )  \"Voltage drop of the two pins (= p.v - n.v)\" type: Real
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001617/0.2276, allocations: 1.366 MB / 497.8 MB, free: 5.863 MB / 378.7 MB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001156/0.2288, allocations: 1.806 MB / 499.6 MB, free: 3.695 MB / 378.7 MB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003916/0.2327, allocations: 3.299 MB / 0.4911 GB, free: 196 kB / 378.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.001e-06/0.2327, allocations: 4 kB / 0.4912 GB, free: 192 kB / 378.7 MB
Notification: Performance of matching and sorting (n=253) (initialization_lambda0): time 0.002472/0.2352, allocations: 2.374 MB / 0.4935 GB, free: 13.75 MB / 394.7 MB
Notification: Performance of prepare postOptimizeDAE: time 5.025e-05/0.2352, allocations: 126.8 kB / 0.4936 GB, free: 13.6 MB / 394.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.265e-06/0.2353, allocations: 8 kB / 0.4936 GB, free: 13.59 MB / 394.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003177/0.2356, allocations: 241.8 kB / 0.4938 GB, free: 13.35 MB / 394.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007023/0.2363, allocations: 395.4 kB / 0.4942 GB, free: 12.96 MB / 394.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001451/0.2377, allocations: 2.164 MB / 0.4963 GB, free: 10.66 MB / 394.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008044/0.2385, allocations: 168.3 kB / 0.4965 GB, free: 10.5 MB / 394.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.139e-05/0.2386, allocations: 79.98 kB / 0.4966 GB, free: 10.42 MB / 394.7 MB
Warning: Assuming fixed start value for the following 6 variables:
         mass.s:VARIABLE(start = 0.0 unit = \"m\" fixed = true )  \"Absolute position of center of component (s = flange_a.s + L/2 = flange_b.s - L/2)\" type: Real
         genset.iceT.wSensor.flange.phi:VARIABLE(flow=false unit = \"rad\" fixed = true )  \"Absolute rotation angle of flange\" type: Real
         mass.v:VARIABLE(start = 0.0 unit = \"m/s\" fixed = true )  \"Absolute velocity of component\" type: Real
         powFilt.y:VARIABLE(flow=false start = powFilt.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         battery.C1.v:VARIABLE(start = 0.0 unit = \"V\" fixed = true )  \"Voltage drop of the two pins (= p.v - n.v)\" type: Real
         battery.cDummy.v:VARIABLE(start = battery.EBatteryMin + battery.SOCInit * (battery.EBatteryMax - battery.EBatteryMin) unit = \"V\" fixed = true )  \"Voltage drop of the two pins (= p.v - n.v)\" type: Real
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 40
 * Number of states: 0 ()
 * Number of discrete variables: 22 (driver.dummy,$PRE.driver.driveCyc.nextTimeEvent,$whenCondition1,dragForce.free,drive.limTau.state,drive.limitingTorque,genset.gen.limTau.state,genset.gen.limitingTorque,driver.driveCyc.nextTimeEventScaled,$PRE.driver.driveCyc.nextTimeEventScaled,driver.driveCyc.nextTimeEvent,dragForce.mode,$PRE.dragForce.mode,dragForce.locked,dragForce.startBackward,$PRE.dragForce.startBackward,dragForce.startForward,$PRE.dragForce.startForward,drive.pDC.integrator1.local_reset,genset.toFuelGrams.local_reset,genset.iceT.tokgFuel.local_reset,genset.gen.pDC.integrator1.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (236):
 * Single equations (assignments): 230
 * Array equations: 0
 * Algorithm blocks: 4
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * 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,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,12)}
Notification: Performance of prepare postOptimizeDAE: time 0.0004145/0.239, allocations: 469.2 kB / 0.497 GB, free: 9.938 MB / 394.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002811/0.2393, allocations: 278.2 kB / 0.4973 GB, free: 9.664 MB / 394.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002595/0.2419, allocations: 2.172 MB / 0.4994 GB, free: 7.426 MB / 394.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.388e-06/0.2419, allocations: 16 kB / 0.4994 GB, free: 7.41 MB / 394.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.038e-06/0.2419, allocations: 0 / 0.4994 GB, free: 7.41 MB / 394.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.08e-05/0.2419, allocations: 7.969 kB / 0.4994 GB, free: 7.402 MB / 394.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.005317/0.2472, allocations: 4.712 MB / 0.504 GB, free: 2.598 MB / 394.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.419e-06/0.2473, allocations: 0 / 0.504 GB, free: 2.598 MB / 394.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006523/0.2479, allocations: 307.5 kB / 0.5043 GB, free: 2.297 MB / 394.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0002946/0.2482, allocations: 201.7 kB / 0.5045 GB, free: 2.094 MB / 394.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.99e-05/0.2483, allocations: 39.98 kB / 0.5045 GB, free: 2.055 MB / 394.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001143/0.2494, allocations: 2.105 MB / 0.5066 GB, free: 15.81 MB / 410.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.508e-06/0.2494, allocations: 11.86 kB / 0.5066 GB, free: 15.8 MB / 410.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003828/0.2533, allocations: 3.231 MB / 0.5098 GB, free: 12.45 MB / 410.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006448/0.2539, allocations: 0.4941 MB / 0.5102 GB, free: 11.96 MB / 410.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001865/0.2541, allocations: 47.92 kB / 0.5103 GB, free: 11.91 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006933/0.2548, allocations: 159.8 kB / 0.5104 GB, free: 11.75 MB / 410.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001912/0.255, allocations: 137.1 kB / 0.5106 GB, free: 11.62 MB / 410.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.204e-05/0.255, allocations: 59.91 kB / 0.5106 GB, free: 11.56 MB / 410.7 MB
Notification: Performance of sorting global known variables: time 0.001966/0.257, allocations: 2.044 MB / 0.5126 GB, free: 9.512 MB / 410.7 MB
Notification: Performance of sort global known variables: time 3.61e-07/0.257, allocations: 0 / 0.5126 GB, free: 9.512 MB / 410.7 MB
Notification: Performance of remove unused functions: time 0.001769/0.2588, allocations: 0.9099 MB / 0.5135 GB, free: 8.602 MB / 410.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 12 (mass.s,mass.v,powFilt.y,genset.gen.pDC.integrator1.y,genset.iceT.inertia.w,genset.iceT.wSensor.flange.phi,genset.iceT.tokgFuel.y,genset.toFuelGrams.y,battery.cBattery.v,battery.C1.v,battery.cDummy.v,drive.pDC.integrator1.y)
 * Number of discrete variables: 11 ($whenCondition1,dragForce.startForward,dragForce.startBackward,dragForce.locked,dragForce.mode,driver.driveCyc.nextTimeEvent,driver.driveCyc.nextTimeEventScaled,genset.gen.limitingTorque,genset.gen.limTau.state,drive.limitingTorque,drive.limTau.state)
 * Number of discrete states: 7 (driver.driveCyc.nextTimeEvent,driver.driveCyc.nextTimeEventScaled,drive.limTau.state,dragForce.mode,dragForce.startForward,dragForce.startBackward,genset.gen.limTau.state)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (146):
 * Single equations (assignments): 138
 * Array equations: 0
 * Algorithm blocks: 4
 * Record equations: 0
 * When equations: 2
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * 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,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,10)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.006187/0.265, allocations: 4.912 MB / 0.5183 GB, free: 4.035 MB / 410.7 MB
Notification: Performance of simCode: created initialization part: time 0.003956/0.2689, allocations: 3.668 MB / 0.5219 GB, free: 184 kB / 410.7 MB
Notification: Performance of simCode: created event and clocks part: time 5.721e-06/0.2689, allocations: 8 kB / 0.5219 GB, free: 176 kB / 410.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.001247/0.2702, allocations: 1.305 MB / 0.5232 GB, free: 14.78 MB / 426.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001405/0.2716, allocations: 500 kB / 0.5237 GB, free: 14.31 MB / 426.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02742/0.299, allocations: 22.89 MB / 0.546 GB, free: 6.855 MB / 442.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001067/0.3001, allocations: 1.282 MB / 0.5473 GB, free: 5.539 MB / 442.7 MB
Notification: Performance of simCode: alias equations: time 0.001156/0.3012, allocations: 400.5 kB / 0.5476 GB, free: 5.145 MB / 442.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001082/0.3023, allocations: 1.223 MB / 0.5488 GB, free: 3.918 MB / 442.7 MB
Notification: Performance of SimCode: time 1.212e-06/0.3023, allocations: 0 / 0.5488 GB, free: 3.918 MB / 442.7 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.2166/0.5189, allocations: 64.83 MB / 0.6121 GB, free: 170.7 MB / 490.7 MB
Notification: Performance of buildModelFMU: Generate platform static: time 10.27/10.79, allocations: 6.094 kB / 0.6122 GB, free: 170.7 MB / 490.7 MB
"
[Timeout remaining time 649]
(rm -f EHPTexamples_latest_EHPTexamples.SHEV.SHEVpowerFilt.pipe ; mkfifo EHPTexamples_latest_EHPTexamples.SHEV.SHEVpowerFilt.pipe ; head -c 1048576 < EHPTexamples_latest_EHPTexamples.SHEV.SHEVpowerFilt.pipe >> ../files/EHPTexamples_latest_EHPTexamples.SHEV.SHEVpowerFilt.sim & python3 -m fmpy simulate  --output-file EHPTexamples_latest_EHPTexamples.SHEV.SHEVpowerFilt_res.csv --start-time 0 --stop-time 400 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.2 EHPTexamples_latest_EHPTexamples_SHEV_SHEVpowerFilt.fmu > EHPTexamples_latest_EHPTexamples.SHEV.SHEVpowerFilt.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 12.635688898153603]
Failed to read output from testmodel.py, exit status != 0:
10.929303611628711 10.937673517 10.76100756
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x77221ecc53a0>