Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends.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.001447/0.001447, allocations: 104.3 kB / 19.76 MB, free: 1.906 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.00161/0.00161, allocations: 214.8 kB / 23.06 MB, free: 4.984 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.438/1.438, allocations: 230.7 MB / 256.9 MB, free: 7.754 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo): time 0.07723/0.07723, allocations: 16.93 MB / 330.2 MB, free: 2.348 MB / 254.1 MB
"
[Timeout remaining time 180]
Using package PowerGrids with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/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)
Running command: translateModel(PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends,tolerance=1e-06,outputFormat="mat",numberOfIntervals=500,variableFilter="GEN.DPu|GEN.H|GEN.IStartPu|GEN.LDPu|GEN.LQ1Pu|GEN.LQ2Pu|GEN.LdPu|GEN.LfPu|GEN.LqPu|GEN.MdPu|GEN.MqPu|GEN.PNom|GEN.PStart|GEN.QStart|GEN.SNom|GEN.T1dPu|GEN.T1qPu|GEN.T2dPu|GEN.T2qPu|GEN.T3dPu|GEN.T3qPu|GEN.T4dPu|GEN.T4qPu|GEN.T5dPu|GEN.T5qPu|GEN.T6dPu|GEN.T6qPu|GEN.Tpd|GEN.Tpd0|GEN.Tppd|GEN.Tppd0|GEN.Tppq|GEN.Tppq0|GEN.Tpq|GEN.Tpq0|GEN.UNom|GEN.UPhaseStart|GEN.UStart|GEN.VStartPu|GEN.cosPhiStart|GEN.excitationPuType|GEN.idPuStart|GEN.ifPuStart|GEN.initOpt|GEN.iqPuStart|GEN.kuf|GEN.lambdadPuStart|GEN.lambdaqPuStart|GEN.localInit|GEN.mrcPu|GEN.neglectTransformerTerms|GEN.omega|GEN.omegaBase|GEN.port.IBase|GEN.port.IStart|GEN.port.PStart|GEN.port.QStart|GEN.port.SBase|GEN.port.SNom|GEN.port.UBase|GEN.port.UNom|GEN.port.UPhaseStart|GEN.port.UStart|GEN.port.VBase|GEN.port.VStart|GEN.port.i.im|GEN.port.i.re|GEN.port.iStart.im|GEN.port.iStart.re|GEN.port.portVariablesPhases|GEN.port.v.im|GEN.port.v.re|GEN.port.vStart.im|GEN.port.vStart.re|GEN.portVariablesPhases|GEN.rDPu|GEN.rQ1Pu|GEN.rQ2Pu|GEN.raPu|GEN.referenceGenerator|GEN.rfPu|GEN.sinPhiStart|GEN.thetaStart|GEN.timeConstApprox|GEN.udPuStart|GEN.ufPuIn|GEN.ufPuInStart|GEN.ufPuStart|GEN.uqPuStart|GEN.xdPu|GEN.xlPu|GEN.xpdPu|GEN.xppdPu|GEN.xppqPu|GEN.xpqPu|GEN.xqPu|GRID.PStart|GRID.QStart|GRID.R_X|GRID.SNom|GRID.SSC|GRID.Ssc.im|GRID.Ssc.re|GRID.UNom|GRID.UPhaseRef|GRID.UPhaseStart|GRID.URef|GRID.UStart|GRID.ZGrid.im|GRID.ZGrid.re|GRID.c|GRID.e.im|GRID.e.re|GRID.eSource.im|GRID.eSource.re|GRID.eStart.im|GRID.eStart.re|GRID.i.im|GRID.i.re|GRID.localInit|GRID.port.IBase|GRID.port.IStart|GRID.port.PStart|GRID.port.QStart|GRID.port.SBase|GRID.port.SNom|GRID.port.UBase|GRID.port.UNom|GRID.port.UPhaseStart|GRID.port.UStart|GRID.port.VBase|GRID.port.VStart|GRID.port.i.im|GRID.port.i.re|GRID.port.iStart.im|GRID.port.iStart.re|GRID.port.portVariablesPhases|GRID.port.v.im|GRID.port.v.re|GRID.port.vStart.im|GRID.port.vStart.re|GRID.portVariablesPhases|GRIDL.PRefConst|GRIDL.PStart|GRIDL.QRefConst|GRIDL.QStart|GRIDL.SNom|GRIDL.UNom|GRIDL.UPhaseStart|GRIDL.URef|GRIDL.UStart|GRIDL.i.im|GRIDL.i.re|GRIDL.localInit|GRIDL.port.IBase|GRIDL.port.IStart|GRIDL.port.PStart|GRIDL.port.QStart|GRIDL.port.SBase|GRIDL.port.SNom|GRIDL.port.UBase|GRIDL.port.UNom|GRIDL.port.UPhaseStart|GRIDL.port.UStart|GRIDL.port.VBase|GRIDL.port.VStart|GRIDL.port.i.im|GRIDL.port.i.re|GRIDL.port.iStart.im|GRIDL.port.iStart.re|GRIDL.port.portVariablesPhases|GRIDL.port.v.im|GRIDL.port.v.re|GRIDL.port.vStart.im|GRIDL.port.vStart.re|GRIDL.portVariablesPhases|GRIDL.v.im|GRIDL.v.re|NTHV.PStart|NTHV.QStart|NTHV.SNom|NTHV.UNom|NTHV.UPhaseStart|NTHV.UStart|NTHV.localInit|NTHV.port.IBase|NTHV.port.IStart|NTHV.port.PStart|NTHV.port.QStart|NTHV.port.SBase|NTHV.port.SNom|NTHV.port.UBase|NTHV.port.UNom|NTHV.port.UPhaseStart|NTHV.port.UStart|NTHV.port.VBase|NTHV.port.VStart|NTHV.port.i.im|NTHV.port.i.re|NTHV.port.iStart.im|NTHV.port.iStart.re|NTHV.port.portVariablesPhases|NTHV.port.v.im|NTHV.port.v.re|NTHV.port.vStart.im|NTHV.port.vStart.re|NTHV.portVariablesPhases|NTLV.PStart|NTLV.QStart|NTLV.SNom|NTLV.UNom|NTLV.UPhaseStart|NTLV.UStart|NTLV.localInit|NTLV.port.IBase|NTLV.port.IStart|NTLV.port.PStart|NTLV.port.QStart|NTLV.port.SBase|NTLV.port.SNom|NTLV.port.UBase|NTLV.port.UNom|NTLV.port.UPhaseStart|NTLV.port.UStart|NTLV.port.VBase|NTLV.port.VStart|NTLV.port.i.im|NTLV.port.i.re|NTLV.port.iStart.im|NTLV.port.iStart.re|NTLV.port.portVariablesPhases|NTLV.port.v.im|NTLV.port.v.re|NTLV.port.vStart.im|NTLV.port.vStart.re|NTLV.portVariablesPhases|TGEN.B|TGEN.G|TGEN.PStartA|TGEN.PStartB|TGEN.QStartA|TGEN.QStartB|TGEN.R|TGEN.SNom|TGEN.UNomA|TGEN.UNomB|TGEN.UPhaseStartA|TGEN.UPhaseStartB|TGEN.UStartA|TGEN.UStartB|TGEN.X|TGEN.YB.im|TGEN.YB.re|TGEN.computePowerBalance|TGEN.iA.im|TGEN.iA.re|TGEN.portA.IBase|TGEN.portA.IStart|TGEN.portA.PStart|TGEN.portA.QStart|TGEN.portA.SBase|TGEN.portA.SNom|TGEN.portA.UBase|TGEN.portA.UNom|TGEN.portA.UPhaseStart|TGEN.portA.UStart|TGEN.portA.VBase|TGEN.portA.VStart|TGEN.portA.iStart.im|TGEN.portA.iStart.re|TGEN.portA.portVariablesPhases|TGEN.portA.vStart.im|TGEN.portA.vStart.re|TGEN.portB.IBase|TGEN.portB.IStart|TGEN.portB.PStart|TGEN.portB.QStart|TGEN.portB.SBase|TGEN.portB.SNom|TGEN.portB.UBase|TGEN.portB.UNom|TGEN.portB.UPhaseStart|TGEN.portB.UStart|TGEN.portB.VBase|TGEN.portB.VStart|TGEN.portB.iStart.im|TGEN.portB.iStart.re|TGEN.portB.portVariablesPhases|TGEN.portB.vStart.im|TGEN.portB.vStart.re|TGEN.portVariablesPhases|TGEN.rFixed|TGEN.thetaFixed|TGEN.vA.im|TGEN.vA.re|systemPowerGrids.fNom|systemPowerGrids.initOpt|systemPowerGrids.omegaNom|systemPowerGrids.omegaRef|systemPowerGrids.referenceFrequency|time|ufPuIn.y",fileNamePrefix="PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends")
translateModel(PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends,tolerance=1e-06,outputFormat="mat",numberOfIntervals=500,variableFilter="GEN.DPu|GEN.H|GEN.IStartPu|GEN.LDPu|GEN.LQ1Pu|GEN.LQ2Pu|GEN.LdPu|GEN.LfPu|GEN.LqPu|GEN.MdPu|GEN.MqPu|GEN.PNom|GEN.PStart|GEN.QStart|GEN.SNom|GEN.T1dPu|GEN.T1qPu|GEN.T2dPu|GEN.T2qPu|GEN.T3dPu|GEN.T3qPu|GEN.T4dPu|GEN.T4qPu|GEN.T5dPu|GEN.T5qPu|GEN.T6dPu|GEN.T6qPu|GEN.Tpd|GEN.Tpd0|GEN.Tppd|GEN.Tppd0|GEN.Tppq|GEN.Tppq0|GEN.Tpq|GEN.Tpq0|GEN.UNom|GEN.UPhaseStart|GEN.UStart|GEN.VStartPu|GEN.cosPhiStart|GEN.excitationPuType|GEN.idPuStart|GEN.ifPuStart|GEN.initOpt|GEN.iqPuStart|GEN.kuf|GEN.lambdadPuStart|GEN.lambdaqPuStart|GEN.localInit|GEN.mrcPu|GEN.neglectTransformerTerms|GEN.omega|GEN.omegaBase|GEN.port.IBase|GEN.port.IStart|GEN.port.PStart|GEN.port.QStart|GEN.port.SBase|GEN.port.SNom|GEN.port.UBase|GEN.port.UNom|GEN.port.UPhaseStart|GEN.port.UStart|GEN.port.VBase|GEN.port.VStart|GEN.port.i.im|GEN.port.i.re|GEN.port.iStart.im|GEN.port.iStart.re|GEN.port.portVariablesPhases|GEN.port.v.im|GEN.port.v.re|GEN.port.vStart.im|GEN.port.vStart.re|GEN.portVariablesPhases|GEN.rDPu|GEN.rQ1Pu|GEN.rQ2Pu|GEN.raPu|GEN.referenceGenerator|GEN.rfPu|GEN.sinPhiStart|GEN.thetaStart|GEN.timeConstApprox|GEN.udPuStart|GEN.ufPuIn|GEN.ufPuInStart|GEN.ufPuStart|GEN.uqPuStart|GEN.xdPu|GEN.xlPu|GEN.xpdPu|GEN.xppdPu|GEN.xppqPu|GEN.xpqPu|GEN.xqPu|GRID.PStart|GRID.QStart|GRID.R_X|GRID.SNom|GRID.SSC|GRID.Ssc.im|GRID.Ssc.re|GRID.UNom|GRID.UPhaseRef|GRID.UPhaseStart|GRID.URef|GRID.UStart|GRID.ZGrid.im|GRID.ZGrid.re|GRID.c|GRID.e.im|GRID.e.re|GRID.eSource.im|GRID.eSource.re|GRID.eStart.im|GRID.eStart.re|GRID.i.im|GRID.i.re|GRID.localInit|GRID.port.IBase|GRID.port.IStart|GRID.port.PStart|GRID.port.QStart|GRID.port.SBase|GRID.port.SNom|GRID.port.UBase|GRID.port.UNom|GRID.port.UPhaseStart|GRID.port.UStart|GRID.port.VBase|GRID.port.VStart|GRID.port.i.im|GRID.port.i.re|GRID.port.iStart.im|GRID.port.iStart.re|GRID.port.portVariablesPhases|GRID.port.v.im|GRID.port.v.re|GRID.port.vStart.im|GRID.port.vStart.re|GRID.portVariablesPhases|GRIDL.PRefConst|GRIDL.PStart|GRIDL.QRefConst|GRIDL.QStart|GRIDL.SNom|GRIDL.UNom|GRIDL.UPhaseStart|GRIDL.URef|GRIDL.UStart|GRIDL.i.im|GRIDL.i.re|GRIDL.localInit|GRIDL.port.IBase|GRIDL.port.IStart|GRIDL.port.PStart|GRIDL.port.QStart|GRIDL.port.SBase|GRIDL.port.SNom|GRIDL.port.UBase|GRIDL.port.UNom|GRIDL.port.UPhaseStart|GRIDL.port.UStart|GRIDL.port.VBase|GRIDL.port.VStart|GRIDL.port.i.im|GRIDL.port.i.re|GRIDL.port.iStart.im|GRIDL.port.iStart.re|GRIDL.port.portVariablesPhases|GRIDL.port.v.im|GRIDL.port.v.re|GRIDL.port.vStart.im|GRIDL.port.vStart.re|GRIDL.portVariablesPhases|GRIDL.v.im|GRIDL.v.re|NTHV.PStart|NTHV.QStart|NTHV.SNom|NTHV.UNom|NTHV.UPhaseStart|NTHV.UStart|NTHV.localInit|NTHV.port.IBase|NTHV.port.IStart|NTHV.port.PStart|NTHV.port.QStart|NTHV.port.SBase|NTHV.port.SNom|NTHV.port.UBase|NTHV.port.UNom|NTHV.port.UPhaseStart|NTHV.port.UStart|NTHV.port.VBase|NTHV.port.VStart|NTHV.port.i.im|NTHV.port.i.re|NTHV.port.iStart.im|NTHV.port.iStart.re|NTHV.port.portVariablesPhases|NTHV.port.v.im|NTHV.port.v.re|NTHV.port.vStart.im|NTHV.port.vStart.re|NTHV.portVariablesPhases|NTLV.PStart|NTLV.QStart|NTLV.SNom|NTLV.UNom|NTLV.UPhaseStart|NTLV.UStart|NTLV.localInit|NTLV.port.IBase|NTLV.port.IStart|NTLV.port.PStart|NTLV.port.QStart|NTLV.port.SBase|NTLV.port.SNom|NTLV.port.UBase|NTLV.port.UNom|NTLV.port.UPhaseStart|NTLV.port.UStart|NTLV.port.VBase|NTLV.port.VStart|NTLV.port.i.im|NTLV.port.i.re|NTLV.port.iStart.im|NTLV.port.iStart.re|NTLV.port.portVariablesPhases|NTLV.port.v.im|NTLV.port.v.re|NTLV.port.vStart.im|NTLV.port.vStart.re|NTLV.portVariablesPhases|TGEN.B|TGEN.G|TGEN.PStartA|TGEN.PStartB|TGEN.QStartA|TGEN.QStartB|TGEN.R|TGEN.SNom|TGEN.UNomA|TGEN.UNomB|TGEN.UPhaseStartA|TGEN.UPhaseStartB|TGEN.UStartA|TGEN.UStartB|TGEN.X|TGEN.YB.im|TGEN.YB.re|TGEN.computePowerBalance|TGEN.iA.im|TGEN.iA.re|TGEN.portA.IBase|TGEN.portA.IStart|TGEN.portA.PStart|TGEN.portA.QStart|TGEN.portA.SBase|TGEN.portA.SNom|TGEN.portA.UBase|TGEN.portA.UNom|TGEN.portA.UPhaseStart|TGEN.portA.UStart|TGEN.portA.VBase|TGEN.portA.VStart|TGEN.portA.iStart.im|TGEN.portA.iStart.re|TGEN.portA.portVariablesPhases|TGEN.portA.vStart.im|TGEN.portA.vStart.re|TGEN.portB.IBase|TGEN.portB.IStart|TGEN.portB.PStart|TGEN.portB.QStart|TGEN.portB.SBase|TGEN.portB.SNom|TGEN.portB.UBase|TGEN.portB.UNom|TGEN.portB.UPhaseStart|TGEN.portB.UStart|TGEN.portB.VBase|TGEN.portB.VStart|TGEN.portB.iStart.im|TGEN.portB.iStart.re|TGEN.portB.portVariablesPhases|TGEN.portB.vStart.im|TGEN.portB.vStart.re|TGEN.portVariablesPhases|TGEN.rFixed|TGEN.thetaFixed|TGEN.vA.im|TGEN.vA.re|systemPowerGrids.fNom|systemPowerGrids.initOpt|systemPowerGrids.omegaNom|systemPowerGrids.omegaRef|systemPowerGrids.referenceFrequency|time|ufPuIn.y",fileNamePrefix="PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.496e-05/1.496e-05, allocations: 2.281 kB / 461.3 MB, free: 1.738 MB / 318.1 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends): time 0.03296/0.03297, allocations: 32.11 MB / 493.4 MB, free: 1.488 MB / 350.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01647/0.04944, allocations: 8.535 MB / 0.4901 GB, free: 8.926 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003533/0.05297, allocations: 87.38 kB / 0.4902 GB, free: 8.84 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.003847/0.05682, allocations: 1.137 MB / 0.4913 GB, free: 7.695 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01079/0.06762, allocations: 3.855 MB / 0.4951 GB, free: 3.863 MB / 366.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004913/0.07253, allocations: 1.936 MB / 0.497 GB, free: 1.961 MB / 366.1 MB
Notification: Performance of NFFlatten.flatten: time 0.012/0.08453, allocations: 8.79 MB / 0.5056 GB, free: 9.152 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003266/0.0878, allocations: 1.427 MB / 0.507 GB, free: 7.691 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005451/0.09325, allocations: 2.818 MB / 0.5097 GB, free: 4.863 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.005116/0.09837, allocations: 2.773 MB / 0.5124 GB, free: 2.078 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001063/0.09943, allocations: 280 kB / 0.5127 GB, free: 1.805 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003558/0.103, allocations: 0.9098 MB / 0.5136 GB, free: 0.8945 MB / 382.1 MB
Notification: Performance of combineBinaries: time 0.2294/0.3324, allocations: 10.85 MB / 0.5242 GB, free: 22.77 MB / 382.1 MB
Notification: Performance of replaceArrayConstructors: time 0.006699/0.3391, allocations: 6.115 MB / 0.5302 GB, free: 19.39 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.003009/0.3421, allocations: 365.4 kB / 0.5305 GB, free: 19.39 MB / 382.1 MB
Notification: Performance of FrontEnd: time 0.0007922/0.3429, allocations: 117.3 kB / 0.5306 GB, free: 19.38 MB / 382.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 680 (526)
 * Number of variables: 680 (680)
Notification: Performance of [SIM] Bindings: time 0.03006/0.373, allocations: 25.67 MB / 0.5557 GB, free: 8.68 MB / 382.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.003298/0.3763, allocations: 2.417 MB / 0.558 GB, free: 7.426 MB / 382.1 MB
Notification: Performance of [SIM] Early Inline: time 0.0142/0.3905, allocations: 14.42 MB / 0.5721 GB, free: 14.45 MB / 398.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.004648/0.3951, allocations: 1.54 MB / 0.5736 GB, free: 13.59 MB / 398.1 MB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.02032/0.4154, allocations: 11.88 MB / 0.5852 GB, free: 3.695 MB / 398.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.002866/0.4183, allocations: 1.329 MB / 0.5865 GB, free: 2.27 MB / 398.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.001247/0.4196, allocations: 0.9275 MB / 0.5874 GB, free: 1.293 MB / 398.1 MB
Notification: Performance of [SIM] Detect States: time 0.002492/0.4221, allocations: 2.305 MB / 0.5897 GB, free: 14.96 MB / 414.1 MB
Notification: Performance of [SIM] Events: time 0.0009963/0.423, allocations: 0.5527 MB / 0.5902 GB, free: 14.4 MB / 414.1 MB
Notification: Performance of [SIM] Partitioning: time 0.004689/0.4277, allocations: 3.839 MB / 0.594 GB, free: 10.21 MB / 414.1 MB
Notification: Performance of [SIM] Causalize: time 0.01359/0.4413, allocations: 9.433 MB / 0.6032 GB, free: 468 kB / 414.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0077/0.449, allocations: 7.207 MB / 0.6102 GB, free: 9.309 MB / 430.1 MB
Notification: Performance of [INI] Simplify: time 0.01184/0.4609, allocations: 6.008 MB / 0.6161 GB, free: 3.25 MB / 430.1 MB
Notification: Performance of [INI] Inline: time 0.02147/0.4823, allocations: 16.88 MB / 0.6326 GB, free: 2.586 MB / 446.1 MB
Notification: Performance of [INI] Partitioning: time 0.001585/0.4839, allocations: 264.8 kB / 0.6328 GB, free: 2.285 MB / 446.1 MB
Notification: Performance of [INI] Cleanup: time 0.003598/0.4875, allocations: 2.081 MB / 0.6349 GB, free: 252 kB / 446.1 MB
Notification: Performance of [INI] Causalize: time 0.03249/0.52, allocations: 17.38 MB / 0.6518 GB, free: 14.84 MB / 478.1 MB
Notification: Performance of [INI] Tearing: time 0.001443/0.5215, allocations: 1.143 MB / 0.653 GB, free: 13.73 MB / 478.1 MB
Notification: Performance of [SIM] Initialization: time 2.394e-06/0.5215, allocations: 0 / 0.653 GB, free: 13.73 MB / 478.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.004914/0.5264, allocations: 3.326 MB / 0.6562 GB, free: 10.16 MB / 478.1 MB
Notification: Performance of [SIM] Remove Dummies: time 3.355e-05/0.5264, allocations: 22.19 kB / 0.6562 GB, free: 10.15 MB / 478.1 MB
Notification: Performance of [SIM] Tearing: time 0.001437/0.5278, allocations: 1.318 MB / 0.6575 GB, free: 8.887 MB / 478.1 MB
Notification: Performance of [SIM] Categorize: time 0.0001/0.5279, allocations: 30.5 kB / 0.6575 GB, free: 8.871 MB / 478.1 MB
Notification: Performance of [SIM] Solve: time 0.02303/0.551, allocations: 15.01 MB / 0.6722 GB, free: 10.05 MB / 494.1 MB
Notification: Performance of [SIM] Jacobian: time 0.02208/0.573, allocations: 20.89 MB / 0.6926 GB, free: 3.41 MB / 0.4981 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 44
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 3
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 6 (6) {GEN.theta, GEN.omegaPu, GEN.lambdafPu, GEN.lambdaDPu, GEN.lambdaQ1Pu, GEN.lambdaQ2Pu}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 27 (27) {$SEV_25, $SEV_24, $SEV_23, $SEV_22, $SEV_21, $SEV_20, $SEV_19, $SEV_18, $SEV_17, $SEV_16, $SEV_15, $SEV_14, $SEV_13, $SEV_12, $SEV_11, $SEV_10, $SEV_9, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_0}
 * Number of clocks: ............................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 356 (scalar:356, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:18)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 3 (linear: 3, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 767 (scalar:767, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:30)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 10 (linear: 10, nonlinear:0)
Notification: Performance of backend: time 0.0003621/0.5734, allocations: 181.6 kB / 0.6928 GB, free: 3.238 MB / 0.4981 GB
Notification: Performance of SimCode: time 0.2865/0.8599, allocations: 19.39 MB / 0.7117 GB, free: 106.4 MB / 0.4981 GB
Notification: Performance of Templates: time 0.08828/0.9482, allocations: 55.01 MB / 0.7654 GB, free: 79.94 MB / 0.4981 GB
"
[Timeout remaining time 659]
make -j1 -f PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends.makefile [Timeout 660]
(rm -f PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends.pipe ; mkfifo PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends.pipe ; head -c 1048576 < PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends.pipe >> ../files/PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends.sim & ./PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifierUsingExtends.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 8.049423710035626]
Failed to read output from testmodel.py, exit status != 0:
0.9570478519890457 0.965484394 0.6201455720000001
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fa2eb73add0>