Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.0.0_Modelica.Electrical.PowerConverters.Examples.DCAC.PolyphaseTwoLevel.PolyphaseTwoLevel_RL.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001848/0.001848, allocations: 124.1 kB / 17.79 MB, free: 5.25 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00197/0.00197, allocations: 198.8 kB / 20.73 MB, free: 2.309 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.446/1.446, allocations: 225.6 MB / 249.1 MB, free: 3.609 MB / 190.1 MB
"
[Timeout remaining time 178]
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(Modelica.Electrical.PowerConverters.Examples.DCAC.PolyphaseTwoLevel.PolyphaseTwoLevel_RL,fileNamePrefix="Modelica_4_0_0_Modelica_Electrical_PowerConverters_Examples_DCAC_PolyphaseTwoLevel_PolyphaseTwoLevel_RL",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Modelica.Electrical.PowerConverters.Examples.DCAC.PolyphaseTwoLevel.PolyphaseTwoLevel_RL,fileNamePrefix="Modelica_4_0_0_Modelica_Electrical_PowerConverters_Examples_DCAC_PolyphaseTwoLevel_PolyphaseTwoLevel_RL",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.001573/0.001573, allocations: 51.91 kB / 365.7 MB, free: 0.8086 MB / 286.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.109/0.1106, allocations: 52.16 MB / 417.8 MB, free: 12.56 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Electrical.PowerConverters.Examples.DCAC.PolyphaseTwoLevel.PolyphaseTwoLevel_RL): time 0.00914/0.1197, allocations: 6.543 MB / 424.4 MB, free: 5.984 MB / 350.1 MB
Notification: Performance of NFInst.instExpressions: time 0.004477/0.1242, allocations: 1.924 MB / 426.3 MB, free: 4.055 MB / 350.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001109/0.1253, allocations: 51.62 kB / 426.3 MB, free: 4.004 MB / 350.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0007381/0.1261, allocations: 309.5 kB / 426.6 MB, free: 3.699 MB / 350.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.001545/0.1276, allocations: 0.5047 MB / 427.1 MB, free: 3.191 MB / 350.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001125/0.1287, allocations: 451.4 kB / 427.6 MB, free: 2.75 MB / 350.1 MB
Notification: Performance of NFFlatten.flatten: time 0.008238/0.137, allocations: 6.963 MB / 434.5 MB, free: 11.77 MB / 366.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.005281/0.1422, allocations: 3.754 MB / 438.3 MB, free: 7.926 MB / 366.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004769/0.147, allocations: 3.089 MB / 441.4 MB, free: 4.828 MB / 366.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.006382/0.1534, allocations: 3.779 MB / 445.2 MB, free: 1.035 MB / 366.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.002463/0.1559, allocations: 0.8086 MB / 446 MB, free: 232 kB / 366.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.209/0.3649, allocations: 0.8007 MB / 446.8 MB, free: 14.82 MB / 366.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.002717/0.3676, allocations: 2.028 MB / 448.8 MB, free: 14.82 MB / 366.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.005888/0.3735, allocations: 3.514 MB / 452.3 MB, free: 14.13 MB / 366.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01666/0.3902, allocations: 10.35 MB / 462.7 MB, free: 12.84 MB / 366.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.23e-06/0.3902, allocations: 0 / 462.7 MB, free: 12.84 MB / 366.1 MB
Notification: Performance of FrontEnd: time 1.272e-06/0.3902, allocations: 0 / 462.7 MB, free: 12.84 MB / 366.1 MB
Notification: Performance of Transformations before backend: time 0.0004238/0.3906, allocations: 0 / 462.7 MB, free: 12.84 MB / 366.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1268
 * Number of variables: 1268
Notification: Performance of Generate backend data structure: time 0.0342/0.4248, allocations: 7.772 MB / 470.4 MB, free: 8.379 MB / 366.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.747e-05/0.4248, allocations: 14.2 kB / 470.4 MB, free: 8.375 MB / 366.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.002828/0.4277, allocations: 0.6844 MB / 471.1 MB, free: 7.879 MB / 366.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00239/0.4301, allocations: 0.6971 MB / 471.8 MB, free: 7.516 MB / 366.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01137/0.4414, allocations: 4.13 MB / 476 MB, free: 5.137 MB / 366.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006327/0.4421, allocations: 392 kB / 476.3 MB, free: 4.957 MB / 366.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002773/0.4448, allocations: 0.5102 MB / 476.8 MB, free: 4.785 MB / 366.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02399/0.4688, allocations: 8.004 MB / 484.9 MB, free: 96 kB / 366.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003169/0.4692, allocations: 17.8 kB / 484.9 MB, free: 88 kB / 366.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002475/0.4716, allocations: 218 kB / 485.1 MB, free: 15.98 MB / 382.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002047/0.4718, allocations: 189.8 kB / 485.3 MB, free: 15.96 MB / 382.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01899/0.4908, allocations: 7.283 MB / 492.6 MB, free: 12.24 MB / 382.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.05098/0.5418, allocations: 21.05 MB / 0.5016 GB, free: 7.555 MB / 398.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.01478/0.5566, allocations: 7.748 MB / 0.5091 GB, free: 15.68 MB / 414.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.008503/0.5651, allocations: 3.621 MB / 0.5127 GB, free: 12.05 MB / 414.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004913/0.5656, allocations: 64.59 kB / 0.5127 GB, free: 12 MB / 414.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.009814/0.5754, allocations: 4.048 MB / 0.5167 GB, free: 7.922 MB / 414.1 MB
Notification: Performance of pre-optimization done (n=457): time 7.304e-06/0.5754, allocations: 0 / 0.5167 GB, free: 7.922 MB / 414.1 MB
Notification: Performance of matching and sorting (n=458): time 0.04847/0.6239, allocations: 19.01 MB / 0.5352 GB, free: 4.742 MB / 430.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0004038/0.6243, allocations: 462.4 kB / 0.5357 GB, free: 4.207 MB / 430.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007698/0.632, allocations: 3.987 MB / 0.5396 GB, free: 244 kB / 430.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.001704/0.6337, allocations: 165.6 kB / 0.5397 GB, free: 72 kB / 430.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.002779/0.6364, allocations: 2.13 MB / 0.5418 GB, free: 13.94 MB / 446.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.002786/0.6392, allocations: 1.465 MB / 0.5432 GB, free: 12.51 MB / 446.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001914/0.6411, allocations: 0.8709 MB / 0.5441 GB, free: 11.63 MB / 446.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001673/0.6413, allocations: 312.1 kB / 0.5444 GB, free: 11.32 MB / 446.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005535/0.6469, allocations: 2.718 MB / 0.547 GB, free: 8.586 MB / 446.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.007082/0.6539, allocations: 3.795 MB / 0.5508 GB, free: 4.387 MB / 446.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01287/0.6668, allocations: 6.358 MB / 0.557 GB, free: 13.71 MB / 462.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.779e-05/0.6668, allocations: 4 kB / 0.557 GB, free: 13.7 MB / 462.1 MB
Notification: Performance of matching and sorting (n=581) (initialization): time 0.01828/0.6851, allocations: 8.043 MB / 0.5648 GB, free: 5.73 MB / 462.1 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001806/0.6853, allocations: 194.2 kB / 0.565 GB, free: 5.504 MB / 462.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.981e-05/0.6854, allocations: 24 kB / 0.565 GB, free: 5.48 MB / 462.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00428/0.6897, allocations: 1.73 MB / 0.5667 GB, free: 3.738 MB / 462.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00404/0.6937, allocations: 0.7712 MB / 0.5675 GB, free: 3.02 MB / 462.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03148/0.7252, allocations: 24.03 MB / 0.5909 GB, free: 10.13 MB / 494.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005216/0.7304, allocations: 403.6 kB / 0.5913 GB, free: 9.738 MB / 494.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001112/0.7315, allocations: 176 kB / 0.5915 GB, free: 9.566 MB / 494.1 MB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01056/0.7421, allocations: 4.318 MB / 0.5957 GB, free: 5.234 MB / 494.1 MB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.006976/0.749, allocations: 3.636 MB / 0.5993 GB, free: 1.191 MB / 494.1 MB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01207/0.7611, allocations: 6.089 MB / 0.6052 GB, free: 10.78 MB / 0.4981 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.107e-05/0.7612, allocations: 15.94 kB / 0.6052 GB, free: 10.76 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=581) (initialization_lambda0): time 0.01766/0.7788, allocations: 7.728 MB / 0.6128 GB, free: 3.102 MB / 0.4981 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001766/0.779, allocations: 182.2 kB / 0.6129 GB, free: 2.887 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.235e-05/0.7791, allocations: 28 kB / 0.613 GB, free: 2.859 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004069/0.7831, allocations: 1.731 MB / 0.6147 GB, free: 1.113 MB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003786/0.7869, allocations: 0.7209 MB / 0.6154 GB, free: 452 kB / 0.4981 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.2594/1.046, allocations: 24.02 MB / 0.6388 GB, free: 161.6 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005225/1.052, allocations: 398.2 kB / 0.6392 GB, free: 161.6 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0009936/1.053, allocations: 180.9 kB / 0.6394 GB, free: 161.6 MB / 0.5137 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 118
 * Number of states: 0 ()
 * Number of discrete variables: 180 (signalPWM[1].zeroOrderHold.firstTrigger,$PRE.signalPWM[1].zeroOrderHold.firstTrigger,signalPWM[2].zeroOrderHold.firstTrigger,$PRE.signalPWM[2].zeroOrderHold.firstTrigger,signalPWM[3].zeroOrderHold.firstTrigger,$PRE.signalPWM[3].zeroOrderHold.firstTrigger,signalPWM[4].zeroOrderHold.firstTrigger,$PRE.signalPWM[4].zeroOrderHold.firstTrigger,signalPWM[5].zeroOrderHold.firstTrigger,$PRE.signalPWM[5].zeroOrderHold.firstTrigger,signalPWM[6].zeroOrderHold.firstTrigger,$PRE.signalPWM[6].zeroOrderHold.firstTrigger,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,fundamentalWaveVoltage[6].mean2.y_last,$PRE.fundamentalWaveVoltage[6].mean2.y_last,fundamentalWaveVoltage[6].mean1.y_last,$PRE.fundamentalWaveVoltage[6].mean1.y_last,fundamentalWaveVoltage[5].mean2.y_last,$PRE.fundamentalWaveVoltage[5].mean2.y_last,fundamentalWaveVoltage[5].mean1.y_last,$PRE.fundamentalWaveVoltage[5].mean1.y_last,fundamentalWaveVoltage[4].mean2.y_last,$PRE.fundamentalWaveVoltage[4].mean2.y_last,fundamentalWaveVoltage[4].mean1.y_last,$PRE.fundamentalWaveVoltage[4].mean1.y_last,fundamentalWaveVoltage[3].mean2.y_last,$PRE.fundamentalWaveVoltage[3].mean2.y_last,fundamentalWaveVoltage[3].mean1.y_last,$PRE.fundamentalWaveVoltage[3].mean1.y_last,fundamentalWaveVoltage[2].mean2.y_last,$PRE.fundamentalWaveVoltage[2].mean2.y_last,fundamentalWaveVoltage[2].mean1.y_last,$PRE.fundamentalWaveVoltage[2].mean1.y_last,fundamentalWaveVoltage[1].mean2.y_last,$PRE.fundamentalWaveVoltage[1].mean2.y_last,fundamentalWaveVoltage[1].mean1.y_last,$PRE.fundamentalWaveVoltage[1].mean1.y_last,fundamentalWaveCurrent[6].mean2.y_last,$PRE.fundamentalWaveCurrent[6].mean2.y_last,fundamentalWaveCurrent[6].mean1.y_last,$PRE.fundamentalWaveCurrent[6].mean1.y_last,fundamentalWaveCurrent[5].mean2.y_last,$PRE.fundamentalWaveCurrent[5].mean2.y_last,fundamentalWaveCurrent[5].mean1.y_last,$PRE.fundamentalWaveCurrent[5].mean1.y_last,fundamentalWaveCurrent[4].mean2.y_last,$PRE.fundamentalWaveCurrent[4].mean2.y_last,fundamentalWaveCurrent[4].mean1.y_last,$PRE.fundamentalWaveCurrent[4].mean1.y_last,fundamentalWaveCurrent[3].mean2.y_last,$PRE.fundamentalWaveCurrent[3].mean2.y_last,fundamentalWaveCurrent[3].mean1.y_last,$PRE.fundamentalWaveCurrent[3].mean1.y_last,fundamentalWaveCurrent[2].mean2.y_last,$PRE.fundamentalWaveCurrent[2].mean2.y_last,fundamentalWaveCurrent[2].mean1.y_last,$PRE.fundamentalWaveCurrent[2].mean1.y_last,fundamentalWaveCurrent[1].mean2.y_last,$PRE.fundamentalWaveCurrent[1].mean2.y_last,fundamentalWaveCurrent[1].mean1.y_last,$PRE.fundamentalWaveCurrent[1].mean1.y_last,signalPWM[6].zeroOrderHold.sampleTrigger,$whenCondition26,signalPWM[6].zeroOrderHold.ySample,signalPWM[5].zeroOrderHold.sampleTrigger,$whenCondition28,signalPWM[5].zeroOrderHold.ySample,signalPWM[4].zeroOrderHold.sampleTrigger,$whenCondition30,signalPWM[4].zeroOrderHold.ySample,signalPWM[3].zeroOrderHold.sampleTrigger,$whenCondition32,signalPWM[3].zeroOrderHold.ySample,signalPWM[2].zeroOrderHold.sampleTrigger,$whenCondition34,signalPWM[2].zeroOrderHold.ySample,signalPWM[1].zeroOrderHold.sampleTrigger,$whenCondition36,signalPWM[1].zeroOrderHold.ySample,signalPWM[6].sawtooth.count,$PRE.signalPWM[6].sawtooth.count,signalPWM[6].sawtooth.T_start,$PRE.signalPWM[6].sawtooth.T_start,$PRE.signalPWM[6].zeroOrderHold.ySample,signalPWM[6].notFire,signalPWM[5].sawtooth.count,$PRE.signalPWM[5].sawtooth.count,signalPWM[5].sawtooth.T_start,$PRE.signalPWM[5].sawtooth.T_start,$PRE.signalPWM[5].zeroOrderHold.ySample,signalPWM[5].notFire,signalPWM[4].sawtooth.count,$PRE.signalPWM[4].sawtooth.count,signalPWM[4].sawtooth.T_start,$PRE.signalPWM[4].sawtooth.T_start,$PRE.signalPWM[4].zeroOrderHold.ySample,signalPWM[4].notFire,signalPWM[3].sawtooth.count,$PRE.signalPWM[3].sawtooth.count,signalPWM[3].sawtooth.T_start,$PRE.signalPWM[3].sawtooth.T_start,$PRE.signalPWM[3].zeroOrderHold.ySample,signalPWM[3].notFire,signalPWM[2].sawtooth.count,$PRE.signalPWM[2].sawtooth.count,signalPWM[2].sawtooth.T_start,$PRE.signalPWM[2].sawtooth.T_start,$PRE.signalPWM[2].zeroOrderHold.ySample,signalPWM[2].notFire,signalPWM[1].sawtooth.count,$PRE.signalPWM[1].sawtooth.count,signalPWM[1].sawtooth.T_start,$PRE.signalPWM[1].sawtooth.T_start,$PRE.signalPWM[1].zeroOrderHold.ySample,signalPWM[1].notFire,inverter.diode_n.idealDiode[6].off,inverter.diode_n.idealDiode[5].off,inverter.diode_n.idealDiode[4].off,inverter.diode_n.idealDiode[3].off,inverter.diode_n.idealDiode[2].off,inverter.diode_n.idealDiode[1].off,inverter.transistor_n.idealGTOThyristor[6].off,inverter.transistor_n.idealGTOThyristor[5].off,inverter.transistor_n.idealGTOThyristor[4].off,inverter.transistor_n.idealGTOThyristor[3].off,inverter.transistor_n.idealGTOThyristor[2].off,inverter.transistor_n.idealGTOThyristor[1].off,inverter.diode_p.idealDiode[6].off,inverter.diode_p.idealDiode[5].off,inverter.diode_p.idealDiode[4].off,inverter.diode_p.idealDiode[3].off,inverter.diode_p.idealDiode[2].off,inverter.diode_p.idealDiode[1].off,inverter.transistor_p.idealGTOThyristor[6].off,inverter.transistor_p.idealGTOThyristor[5].off,inverter.transistor_p.idealGTOThyristor[4].off,inverter.transistor_p.idealGTOThyristor[3].off,inverter.transistor_p.idealGTOThyristor[2].off,inverter.transistor_p.idealGTOThyristor[1].off,inverter.andCondition_n[6].y,inverter.andCondition_n[5].y,inverter.andCondition_n[4].y,inverter.andCondition_n[3].y,inverter.andCondition_n[2].y,inverter.andCondition_n[1].y,inverter.andCondition_p[6].y,inverter.andCondition_p[5].y,inverter.andCondition_p[4].y,inverter.andCondition_p[3].y,inverter.andCondition_p[2].y,inverter.andCondition_p[1].y,$whenCondition25,$whenCondition27,$whenCondition29,$whenCondition31,$whenCondition33,$whenCondition35)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (461):
 * Single equations (assignments): 448
 * Array equations: 0
 * Algorithm blocks: 6
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 7
 * 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,18,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 6 systems
   {(4,13), (4,13), (4,13), (4,13), (4,13), (4,13)}
Notification: Performance of prepare postOptimizeDAE: time 0.001697/1.054, allocations: 0.5964 MB / 0.64 GB, free: 161.4 MB / 0.5137 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001388/1.056, allocations: 481.1 kB / 0.6404 GB, free: 161.4 MB / 0.5137 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01569/1.071, allocations: 7.683 MB / 0.6479 GB, free: 161.2 MB / 0.5137 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.871e-05/1.071, allocations: 44 kB / 0.648 GB, free: 161.2 MB / 0.5137 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.492e-05/1.071, allocations: 6.281 kB / 0.648 GB, free: 161.2 MB / 0.5137 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.008e-05/1.071, allocations: 23.06 kB / 0.648 GB, free: 161.2 MB / 0.5137 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02656/1.098, allocations: 13.66 MB / 0.6613 GB, free: 156.9 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.484e-05/1.098, allocations: 3.188 kB / 0.6613 GB, free: 156.9 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002633/1.101, allocations: 0.5609 MB / 0.6619 GB, free: 156.7 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003316/1.104, allocations: 1.71 MB / 0.6635 GB, free: 155.8 MB / 0.5137 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0008133/1.105, allocations: 126.9 kB / 0.6637 GB, free: 155.7 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02042/1.125, allocations: 23.86 MB / 0.687 GB, free: 133.8 MB / 0.5137 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.076e-06/1.125, allocations: 4 kB / 0.687 GB, free: 133.8 MB / 0.5137 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01773/1.143, allocations: 11.35 MB / 0.6981 GB, free: 122.7 MB / 0.5137 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00319/1.146, allocations: 1.16 MB / 0.6992 GB, free: 121.8 MB / 0.5137 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001586/1.148, allocations: 163.9 kB / 0.6993 GB, free: 121.6 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003752/1.152, allocations: 389.3 kB / 0.6997 GB, free: 121.2 MB / 0.5137 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001745/1.153, allocations: 0.7547 MB / 0.7004 GB, free: 120.5 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000455/1.154, allocations: 151.8 kB / 0.7006 GB, free: 120.3 MB / 0.5137 GB
Notification: Performance of sorting global known variables: time 0.004073/1.158, allocations: 2.764 MB / 0.7033 GB, free: 117.6 MB / 0.5137 GB
Notification: Performance of sort global known variables: time 8e-08/1.158, allocations: 0 / 0.7033 GB, free: 117.6 MB / 0.5137 GB
Notification: Performance of remove unused functions: time 0.0106/1.168, allocations: 2.207 MB / 0.7054 GB, free: 115.4 MB / 0.5137 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 6
 * Number of states: 29 (fundamentalWaveCurrent[1].mean1.x,fundamentalWaveCurrent[1].mean2.x,fundamentalWaveCurrent[2].mean1.x,fundamentalWaveCurrent[2].mean2.x,fundamentalWaveCurrent[3].mean1.x,fundamentalWaveCurrent[3].mean2.x,fundamentalWaveCurrent[4].mean1.x,fundamentalWaveCurrent[4].mean2.x,fundamentalWaveCurrent[5].mean1.x,fundamentalWaveCurrent[5].mean2.x,fundamentalWaveCurrent[6].mean1.x,fundamentalWaveCurrent[6].mean2.x,fundamentalWaveVoltage[1].mean1.x,fundamentalWaveVoltage[1].mean2.x,fundamentalWaveVoltage[2].mean1.x,fundamentalWaveVoltage[2].mean2.x,fundamentalWaveVoltage[3].mean1.x,fundamentalWaveVoltage[3].mean2.x,fundamentalWaveVoltage[4].mean1.x,fundamentalWaveVoltage[4].mean2.x,fundamentalWaveVoltage[5].mean1.x,fundamentalWaveVoltage[5].mean2.x,fundamentalWaveVoltage[6].mean1.x,fundamentalWaveVoltage[6].mean2.x,inductor.inductor[2].i,inductor.inductor[3].i,inductor.inductor[4].i,inductor.inductor[5].i,inductor.inductor[6].i)
 * Number of discrete variables: 132 (signalPWM[1].zeroOrderHold.sampleTrigger,signalPWM[2].zeroOrderHold.sampleTrigger,signalPWM[3].zeroOrderHold.sampleTrigger,signalPWM[4].zeroOrderHold.sampleTrigger,signalPWM[5].zeroOrderHold.sampleTrigger,signalPWM[6].zeroOrderHold.sampleTrigger,$whenCondition36,$whenCondition35,$whenCondition34,$whenCondition33,$whenCondition32,$whenCondition31,$whenCondition30,$whenCondition29,$whenCondition28,$whenCondition27,$whenCondition26,$whenCondition25,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,inverter.andCondition_p[1].y,inverter.andCondition_p[2].y,inverter.andCondition_p[3].y,inverter.andCondition_p[4].y,inverter.andCondition_p[5].y,inverter.andCondition_p[6].y,inverter.andCondition_n[1].y,inverter.andCondition_n[2].y,inverter.andCondition_n[3].y,inverter.andCondition_n[4].y,inverter.andCondition_n[5].y,inverter.andCondition_n[6].y,inverter.transistor_p.idealGTOThyristor[1].off,inverter.transistor_p.idealGTOThyristor[2].off,inverter.transistor_p.idealGTOThyristor[3].off,inverter.transistor_p.idealGTOThyristor[4].off,inverter.transistor_p.idealGTOThyristor[5].off,inverter.transistor_p.idealGTOThyristor[6].off,inverter.diode_p.idealDiode[1].off,inverter.diode_p.idealDiode[2].off,inverter.diode_p.idealDiode[3].off,inverter.diode_p.idealDiode[4].off,inverter.diode_p.idealDiode[5].off,inverter.diode_p.idealDiode[6].off,inverter.transistor_n.idealGTOThyristor[1].off,inverter.transistor_n.idealGTOThyristor[2].off,inverter.transistor_n.idealGTOThyristor[3].off,inverter.transistor_n.idealGTOThyristor[4].off,inverter.transistor_n.idealGTOThyristor[5].off,inverter.transistor_n.idealGTOThyristor[6].off,inverter.diode_n.idealDiode[1].off,inverter.diode_n.idealDiode[2].off,inverter.diode_n.idealDiode[3].off,inverter.diode_n.idealDiode[4].off,inverter.diode_n.idealDiode[5].off,inverter.diode_n.idealDiode[6].off,signalPWM[1].notFire,signalPWM[1].zeroOrderHold.firstTrigger,signalPWM[1].zeroOrderHold.ySample,signalPWM[1].sawtooth.T_start,signalPWM[1].sawtooth.count,signalPWM[2].notFire,signalPWM[2].zeroOrderHold.firstTrigger,signalPWM[2].zeroOrderHold.ySample,signalPWM[2].sawtooth.T_start,signalPWM[2].sawtooth.count,signalPWM[3].notFire,signalPWM[3].zeroOrderHold.firstTrigger,signalPWM[3].zeroOrderHold.ySample,signalPWM[3].sawtooth.T_start,signalPWM[3].sawtooth.count,signalPWM[4].notFire,signalPWM[4].zeroOrderHold.firstTrigger,signalPWM[4].zeroOrderHold.ySample,signalPWM[4].sawtooth.T_start,signalPWM[4].sawtooth.count,signalPWM[5].notFire,signalPWM[5].zeroOrderHold.firstTrigger,signalPWM[5].zeroOrderHold.ySample,signalPWM[5].sawtooth.T_start,signalPWM[5].sawtooth.count,signalPWM[6].notFire,signalPWM[6].zeroOrderHold.firstTrigger,signalPWM[6].zeroOrderHold.ySample,signalPWM[6].sawtooth.T_start,signalPWM[6].sawtooth.count,fundamentalWaveCurrent[1].mean1.y_last,fundamentalWaveCurrent[1].mean2.y_last,fundamentalWaveCurrent[2].mean1.y_last,fundamentalWaveCurrent[2].mean2.y_last,fundamentalWaveCurrent[3].mean1.y_last,fundamentalWaveCurrent[3].mean2.y_last,fundamentalWaveCurrent[4].mean1.y_last,fundamentalWaveCurrent[4].mean2.y_last,fundamentalWaveCurrent[5].mean1.y_last,fundamentalWaveCurrent[5].mean2.y_last,fundamentalWaveCurrent[6].mean1.y_last,fundamentalWaveCurrent[6].mean2.y_last,fundamentalWaveVoltage[1].mean1.y_last,fundamentalWaveVoltage[1].mean2.y_last,fundamentalWaveVoltage[2].mean1.y_last,fundamentalWaveVoltage[2].mean2.y_last,fundamentalWaveVoltage[3].mean1.y_last,fundamentalWaveVoltage[3].mean2.y_last,fundamentalWaveVoltage[4].mean1.y_last,fundamentalWaveVoltage[4].mean2.y_last,fundamentalWaveVoltage[5].mean1.y_last,fundamentalWaveVoltage[5].mean2.y_last,fundamentalWaveVoltage[6].mean1.y_last,fundamentalWaveVoltage[6].mean2.y_last)
 * Number of discrete states: 36 (signalPWM[1].sawtooth.count,signalPWM[2].sawtooth.count,signalPWM[3].sawtooth.count,signalPWM[4].sawtooth.count,signalPWM[5].sawtooth.count,signalPWM[6].sawtooth.count,fundamentalWaveCurrent[1].mean1.x,fundamentalWaveCurrent[1].mean2.x,fundamentalWaveCurrent[2].mean1.x,fundamentalWaveCurrent[2].mean2.x,fundamentalWaveCurrent[3].mean1.x,fundamentalWaveCurrent[3].mean2.x,fundamentalWaveCurrent[4].mean1.x,fundamentalWaveCurrent[4].mean2.x,fundamentalWaveCurrent[5].mean1.x,fundamentalWaveCurrent[5].mean2.x,fundamentalWaveCurrent[6].mean1.x,fundamentalWaveCurrent[6].mean2.x,fundamentalWaveVoltage[1].mean1.x,fundamentalWaveVoltage[1].mean2.x,fundamentalWaveVoltage[2].mean1.x,fundamentalWaveVoltage[2].mean2.x,fundamentalWaveVoltage[3].mean1.x,fundamentalWaveVoltage[3].mean2.x,fundamentalWaveVoltage[4].mean1.x,fundamentalWaveVoltage[4].mean2.x,fundamentalWaveVoltage[5].mean1.x,fundamentalWaveVoltage[5].mean2.x,fundamentalWaveVoltage[6].mean1.x,fundamentalWaveVoltage[6].mean2.x,signalPWM[6].zeroOrderHold.ySample,signalPWM[5].zeroOrderHold.ySample,signalPWM[4].zeroOrderHold.ySample,signalPWM[3].zeroOrderHold.ySample,signalPWM[2].zeroOrderHold.ySample,signalPWM[1].zeroOrderHold.ySample)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (344):
 * Single equations (assignments): 289
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 48
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 7
 * 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,18,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 6 systems
   {(4,13), (4,13), (4,13), (4,13), (4,13), (4,13)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01741/1.186, allocations: 12.25 MB / 0.7174 GB, free: 103.1 MB / 0.5137 GB
Notification: Performance of simCode: created initialization part: time 0.01861/1.204, allocations: 13.13 MB / 0.7302 GB, free: 89.66 MB / 0.5137 GB
Notification: Performance of simCode: created event and clocks part: time 1.201e-05/1.204, allocations: 1.656 kB / 0.7302 GB, free: 89.66 MB / 0.5137 GB
Notification: Performance of simCode: created simulation system equations: time 0.007857/1.212, allocations: 5.06 MB / 0.7352 GB, free: 84.52 MB / 0.5137 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005706/1.218, allocations: 1.133 MB / 0.7363 GB, free: 83.43 MB / 0.5137 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.08315/1.301, allocations: 51.9 MB / 0.787 GB, free: 30.59 MB / 0.5137 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003465/1.305, allocations: 4.109 MB / 0.791 GB, free: 26.44 MB / 0.5137 GB
Notification: Performance of simCode: alias equations: time 0.004561/1.309, allocations: 1.975 MB / 0.7929 GB, free: 24.46 MB / 0.5137 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002759/1.312, allocations: 2.136 MB / 0.795 GB, free: 22.32 MB / 0.5137 GB
Notification: Performance of SimCode: time 1.634e-06/1.312, allocations: 3.938 kB / 0.795 GB, free: 22.32 MB / 0.5137 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.4482/1.76, allocations: 151.6 MB / 0.943 GB, free: 88.25 MB / 0.5294 GB
Notification: Performance of buildModelFMU: Generate platform static: time 22.62/24.38, allocations: 5.734 kB / 0.943 GB, free: 88.25 MB / 0.5294 GB
"
[Timeout remaining time 635]
(rm -f Modelica_4.0.0_Modelica.Electrical.PowerConverters.Examples.DCAC.PolyphaseTwoLevel.PolyphaseTwoLevel_RL.pipe ; mkfifo Modelica_4.0.0_Modelica.Electrical.PowerConverters.Examples.DCAC.PolyphaseTwoLevel.PolyphaseTwoLevel_RL.pipe ; head -c 1048576 < Modelica_4.0.0_Modelica.Electrical.PowerConverters.Examples.DCAC.PolyphaseTwoLevel.PolyphaseTwoLevel_RL.pipe >> ../files/Modelica_4.0.0_Modelica.Electrical.PowerConverters.Examples.DCAC.PolyphaseTwoLevel.PolyphaseTwoLevel_RL.sim & python3 -m fmpy simulate  --output-file Modelica_4.0.0_Modelica.Electrical.PowerConverters.Examples.DCAC.PolyphaseTwoLevel.PolyphaseTwoLevel_RL_res.csv --start-time 0 --stop-time 0.1 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 2e-05 Modelica_4_0_0_Modelica_Electrical_PowerConverters_Examples_DCAC_PolyphaseTwoLevel_PolyphaseTwoLevel_RL.fmu > Modelica_4.0.0_Modelica.Electrical.PowerConverters.Examples.DCAC.PolyphaseTwoLevel.PolyphaseTwoLevel_RL.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 27.14127879589796]
Failed to read output from testmodel.py, exit status != 0:
['time', 'inductor.inductor[2].i', 'inductor.inductor[3].i', 'inductor.inductor[4].i', 'inductor.inductor[5].i', 'inductor.inductor[6].i', 'fundamentalWaveCurrent[1].mean1.y', 'fundamentalWaveCurrent[1].mean2.y', 'fundamentalWaveCurrent[2].mean1.y', 'fundamentalWaveCurrent[2].mean2.y', 'fundamentalWaveCurrent[3].mean1.y', 'fundamentalWaveCurrent[3].mean2.y', 'fundamentalWaveCurrent[4].mean1.y', 'fundamentalWaveCurrent[4].mean2.y', 'fundamentalWaveCurrent[5].mean1.y', 'fundamentalWaveCurrent[5].mean2.y', 'fundamentalWaveCurrent[6].mean1.y', 'fundamentalWaveCurrent[6].mean2.y', 'fundamentalWaveVoltage[1].mean1.y', 'fundamentalWaveVoltage[1].mean2.y', 'fundamentalWaveVoltage[2].mean1.y', 'fundamentalWaveVoltage[2].mean2.y', 'fundamentalWaveVoltage[3].mean1.y', 'fundamentalWaveVoltage[3].mean2.y', 'fundamentalWaveVoltage[4].mean1.y', 'fundamentalWaveVoltage[4].mean2.y', 'fundamentalWaveVoltage[5].mean1.y', 'fundamentalWaveVoltage[5].mean2.y', 'fundamentalWaveVoltage[6].mean1.y', 'fundamentalWaveVoltage[6].mean2.y', 'inverter.ac.pin[1].v', 'inverter.ac.pin[1].i', 'inverter.ac.pin[2].v', 'inverter.ac.pin[2].i', 'inverter.ac.pin[3].v', 'inverter.ac.pin[3].i', 'inverter.ac.pin[4].v', 'inverter.ac.pin[4].i', 'inverter.ac.pin[5].v', 'inverter.ac.pin[5].i', 'inverter.ac.pin[6].v', 'inverter.ac.pin[6].i', 'currentSensor.i[1]', 'currentSensor.i[2]', 'currentSensor.i[3]', 'voltageSensor.v[1]', 'voltageSensor.v[2]', 'voltageSensor.v[3]']
24.555217967834324 24.563344513 24.170737963
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f75602d97e0>