Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifier.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001641/0.001641, allocations: 103.4 kB / 18.19 MB, free: 4.117 MB / 14.72 MB
[Timeout remaining time 90]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00169/0.00169, allocations: 193.9 kB / 21.34 MB, free: 0.9766 MB / 14.72 MB
[Timeout remaining time 90]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.43/1.43, allocations: 225.6 MB / 249.9 MB, free: 3.246 MB / 190.1 MB
[Timeout remaining time 88]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo): time 0.07899/0.07899, allocations: 16.96 MB / 322 MB, free: 12.73 MB / 254.1 MB
[Timeout remaining time 90]
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.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: translateModel(PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifier,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.LoadChangeByModifier")
translateModel(PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifier,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.LoadChangeByModifier") [Timeout 660]
Notification: Performance of FrontEnd - loaded program: time 0.002048/0.002048, allocations: 64.77 kB / 450 MB, free: 45.11 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1284/0.1304, allocations: 56.52 MB / 0.4947 GB, free: 17.79 MB / 366.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:4:3-5:21:writable] Warning: Parameter GEN.componentPF.UNom has no value, and is fixed during initialization (fixed=true), using available start value (start=400e3) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:6:3-7:21:writable] Warning: Parameter GEN.componentPF.SNom has no value, and is fixed during initialization (fixed=true), using available start value (start=100e6) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:4:3-5:21:writable] Warning: Parameter NTLV.componentPF.UNom has no value, and is fixed during initialization (fixed=true), using available start value (start=400e3) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:6:3-7:21:writable] Warning: Parameter NTLV.componentPF.SNom has no value, and is fixed during initialization (fixed=true), using available start value (start=100e6) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/TwoPortACVI.mo:4:3-5:21:writable] Warning: Parameter TGEN.componentPF.UNomA has no value, and is fixed during initialization (fixed=true), using available start value (start=400e3) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/TwoPortACVI.mo:8:3-9:21:writable] Warning: Parameter TGEN.componentPF.SNom has no value, and is fixed during initialization (fixed=true), using available start value (start=100e6) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:4:3-5:21:writable] Warning: Parameter GRID.componentPF.UNom has no value, and is fixed during initialization (fixed=true), using available start value (start=400e3) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:6:3-7:21:writable] Warning: Parameter GRID.componentPF.SNom has no value, and is fixed during initialization (fixed=true), using available start value (start=100e6) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:4:3-5:21:writable] Warning: Parameter GRIDL.componentPF.UNom has no value, and is fixed during initialization (fixed=true), using available start value (start=400e3) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:6:3-7:21:writable] Warning: Parameter GRIDL.componentPF.SNom has no value, and is fixed during initialization (fixed=true), using available start value (start=100e6) as default value.
Notification: Performance of NFInst.instantiate(PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifier): time 0.03249/0.1629, allocations: 37.32 MB / 0.5311 GB, free: 14.46 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01929/0.1822, allocations: 9.072 MB / 0.54 GB, free: 5.363 MB / 398.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005402/0.1876, allocations: 67.69 kB / 0.5401 GB, free: 5.297 MB / 398.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.005063/0.1927, allocations: 1.196 MB / 0.5412 GB, free: 4.094 MB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01363/0.2063, allocations: 3.915 MB / 0.5451 GB, free: 200 kB / 398.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005843/0.2121, allocations: 1.962 MB / 0.547 GB, free: 14.27 MB / 414.1 MB
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NFFrontEnd/NFFunction.mo:2655:11-2655:130:writable] Error: Internal error NFFunction.Function.getBody2 got function with external section (not algorithm section)
Notification: Performance of NFFlatten.flatten: time 0.0132/0.2253, allocations: 7.296 MB / 0.5541 GB, free: 6.957 MB / 414.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002568/0.2279, allocations: 0.939 MB / 0.555 GB, free: 5.98 MB / 414.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005255/0.2332, allocations: 2.487 MB / 0.5574 GB, free: 3.484 MB / 414.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.005551/0.2387, allocations: 2.615 MB / 0.56 GB, free: 0.8594 MB / 414.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001314/0.24, allocations: 348 kB / 0.5603 GB, free: 0.5195 MB / 414.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003713/0.2437, allocations: 0.8903 MB / 0.5612 GB, free: 15.63 MB / 430.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.000945/0.2447, allocations: 0.8051 MB / 0.562 GB, free: 14.82 MB / 430.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.004495/0.2492, allocations: 2.325 MB / 0.5643 GB, free: 12.48 MB / 430.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01049/0.2597, allocations: 5.749 MB / 0.5699 GB, free: 6.715 MB / 430.1 MB
Notification: Performance of FrontEnd - DAE generated: time 7.605e-06/0.2597, allocations: 0 / 0.5699 GB, free: 6.715 MB / 430.1 MB
Notification: Performance of FrontEnd: time 2.164e-06/0.2597, allocations: 0 / 0.5699 GB, free: 6.715 MB / 430.1 MB
Notification: Performance of Transformations before backend: time 0.0001798/0.2599, allocations: 0 / 0.5699 GB, free: 6.715 MB / 430.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 680
 * Number of variables: 680
Notification: Performance of Generate backend data structure: time 0.02275/0.2826, allocations: 5.952 MB / 0.5757 GB, free: 0.6875 MB / 430.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.482e-05/0.2827, allocations: 8.031 kB / 0.5757 GB, free: 0.6797 MB / 430.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005277/0.2879, allocations: 0.9235 MB / 0.5766 GB, free: 15.75 MB / 446.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00701/0.295, allocations: 2.524 MB / 0.5791 GB, free: 13.16 MB / 446.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001953/0.2951, allocations: 221.7 kB / 0.5793 GB, free: 12.94 MB / 446.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005066/0.2957, allocations: 300.1 kB / 0.5796 GB, free: 12.65 MB / 446.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005746/0.3014, allocations: 3.191 MB / 0.5827 GB, free: 9.066 MB / 446.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 5.726e-05/0.3015, allocations: 19.81 kB / 0.5827 GB, free: 9.047 MB / 446.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003166/0.3018, allocations: 128 kB / 0.5828 GB, free: 8.922 MB / 446.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.618e-05/0.3018, allocations: 72 kB / 0.5829 GB, free: 8.852 MB / 446.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00457/0.3064, allocations: 2.561 MB / 0.5854 GB, free: 6.273 MB / 446.1 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.03351/0.3399, allocations: 20.93 MB / 0.6058 GB, free: 324 kB / 462.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.3346/0.6746, allocations: 2.782 MB / 0.6085 GB, free: 96.74 MB / 462.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001475/0.676, allocations: 0.8212 MB / 0.6093 GB, free: 96.72 MB / 462.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001396/0.6762, allocations: 41.12 kB / 0.6094 GB, free: 96.72 MB / 462.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.487e-05/0.6762, allocations: 64.22 kB / 0.6094 GB, free: 96.68 MB / 462.1 MB
Notification: Performance of pre-optimization done (n=247): time 6.893e-06/0.6762, allocations: 0 / 0.6094 GB, free: 96.68 MB / 462.1 MB
Notification: Performance of matching and sorting (n=247): time 0.01438/0.6906, allocations: 4.45 MB / 0.6138 GB, free: 96.14 MB / 462.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.409e-05/0.6907, allocations: 107.1 kB / 0.6139 GB, free: 96.04 MB / 462.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.006209/0.6969, allocations: 2.968 MB / 0.6168 GB, free: 94.95 MB / 462.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0006453/0.6975, allocations: 94.73 kB / 0.6169 GB, free: 94.87 MB / 462.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001171/0.6987, allocations: 1.508 MB / 0.6184 GB, free: 94.05 MB / 462.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001391/0.7001, allocations: 1.027 MB / 0.6194 GB, free: 93.42 MB / 462.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002595/0.7027, allocations: 1.426 MB / 0.6207 GB, free: 92.73 MB / 462.1 MB
Notification: Performance of setup shared object (initialization): time 6.071e-05/0.7028, allocations: 309.6 kB / 0.621 GB, free: 92.43 MB / 462.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003779/0.7065, allocations: 2.092 MB / 0.6231 GB, free: 91.58 MB / 462.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004188/0.7107, allocations: 2.853 MB / 0.6259 GB, free: 90.18 MB / 462.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005523/0.7162, allocations: 4.081 MB / 0.6299 GB, free: 87.9 MB / 462.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.27e-05/0.7163, allocations: 6.875 kB / 0.6299 GB, free: 87.89 MB / 462.1 MB
Notification: Performance of matching and sorting (n=1011) (initialization): time 0.0123/0.7286, allocations: 6.99 MB / 0.6367 GB, free: 83.96 MB / 462.1 MB
Notification: Performance of prepare postOptimizeDAE: time 4.279e-05/0.7286, allocations: 8 kB / 0.6367 GB, free: 83.96 MB / 462.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.278e-05/0.7286, allocations: 15.78 kB / 0.6367 GB, free: 83.95 MB / 462.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008773/0.7374, allocations: 1.486 MB / 0.6382 GB, free: 82.46 MB / 462.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006695/0.7441, allocations: 1.564 MB / 0.6397 GB, free: 80.89 MB / 462.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01545/0.7596, allocations: 17.91 MB / 0.6572 GB, free: 61.64 MB / 462.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007976/0.7675, allocations: 0.5149 MB / 0.6577 GB, free: 61.24 MB / 462.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001457/0.769, allocations: 255.9 kB / 0.6579 GB, free: 60.99 MB / 462.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 45
 * Number of states: 0 ()
 * Number of discrete variables: 4 (GRIDL.componentPF.isSlackBus,GRID.componentPF.isSlackBus,NTLV.componentPF.isSlackBus,GEN.componentPF.isSlackBus)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (965):
 * Single equations (assignments): 955
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 10
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(2,0,100.0%), (2,0,100.0%), (2,0,100.0%), (2,0,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 6 systems
   {(21,0), (19,0), (2,0), (2,0), (2,0), (2,0)}
Notification: Performance of prepare postOptimizeDAE: time 0.003134/0.7721, allocations: 0.7345 MB / 0.6586 GB, free: 60.25 MB / 462.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001591/0.7737, allocations: 361.8 kB / 0.659 GB, free: 59.89 MB / 462.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005333/0.779, allocations: 2.592 MB / 0.6615 GB, free: 57.28 MB / 462.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.535e-05/0.7791, allocations: 11.95 kB / 0.6615 GB, free: 57.27 MB / 462.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.887e-06/0.7791, allocations: 4.562 kB / 0.6615 GB, free: 57.27 MB / 462.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.002602/0.7817, allocations: 0.7469 MB / 0.6623 GB, free: 56.52 MB / 462.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001365/0.783, allocations: 40 kB / 0.6623 GB, free: 56.48 MB / 462.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003403/0.7864, allocations: 111.9 kB / 0.6624 GB, free: 56.37 MB / 462.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003585/0.7868, allocations: 179.5 kB / 0.6626 GB, free: 56.2 MB / 462.1 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.00572/0.7925, allocations: 2.649 MB / 0.6652 GB, free: 53.59 MB / 462.1 MB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.004993/0.7975, allocations: 3.168 MB / 0.6683 GB, free: 50.4 MB / 462.1 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001043/0.7986, allocations: 0.7325 MB / 0.669 GB, free: 49.67 MB / 462.1 MB
Notification: Performance of sorting global known variables: time 0.003576/0.8021, allocations: 1.79 MB / 0.6707 GB, free: 47.88 MB / 462.1 MB
Notification: Performance of Backend: time 2.6e-07/0.8021, allocations: 0 / 0.6707 GB, free: 47.88 MB / 462.1 MB
Notification: Performance of simCode: created initialization part: time 0.01449/0.8166, allocations: 5.423 MB / 0.676 GB, free: 42.41 MB / 462.1 MB
Notification: Performance of SimCode: time 0.01387/0.8305, allocations: 7.49 MB / 0.6833 GB, free: 34.94 MB / 462.1 MB
Notification: Performance of Templates: time 0.1375/0.968, allocations: 122.1 MB / 0.8025 GB, free: 8.754 MB / 0.545 GB
[Timeout remaining time 659]
make -j1 -f PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifier.makefile [Timeout 660]
(rm -f PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifier.pipe ; mkfifo PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifier.pipe ; head -c 1048576 < PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifier.pipe >> ../files/PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifier.sim & ./PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifier  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > PowerGrids_dev_PowerGrids.Examples.Tutorial.GridOperation.LoadChange.LoadChangeByModifier.pipe 2>&1) [Timeout 480]