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.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.001552/0.001552, allocations: 103.7 kB / 18.19 MB, free: 3.879 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.001575/0.001575, allocations: 188.4 kB / 21.34 MB, free: 0.7383 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.424/1.424, allocations: 225.6 MB / 249.9 MB, free: 13.43 MB / 206.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.07881/0.07881, allocations: 16.94 MB / 322 MB, free: 8.609 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.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 - loaded program: time 0.001956/0.001956, allocations: 63.89 kB / 450.1 MB, free: 9.746 MB / 318.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1271/0.129, allocations: 56.52 MB / 0.4947 GB, free: 1.113 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.LoadChangeByModifierUsingExtends): time 0.3304/0.4594, allocations: 37.33 MB / 0.5312 GB, free: 3.703 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01768/0.477, allocations: 9.074 MB / 0.54 GB, free: 14.6 MB / 398.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005747/0.4828, allocations: 66.03 kB / 0.5401 GB, free: 14.58 MB / 398.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.004994/0.4878, allocations: 1.192 MB / 0.5413 GB, free: 13.97 MB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01372/0.5015, allocations: 3.916 MB / 0.5451 GB, free: 11.35 MB / 398.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005819/0.5073, allocations: 1.964 MB / 0.547 GB, free: 10.27 MB / 398.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.01345/0.5208, allocations: 7.308 MB / 0.5542 GB, free: 6.027 MB / 398.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002448/0.5232, allocations: 0.9383 MB / 0.5551 GB, free: 5.34 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005996/0.5292, allocations: 2.487 MB / 0.5575 GB, free: 3.824 MB / 398.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.006714/0.5359, allocations: 2.611 MB / 0.56 GB, free: 2.031 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.00174/0.5377, allocations: 347.5 kB / 0.5604 GB, free: 2.031 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.005325/0.543, allocations: 0.8958 MB / 0.5613 GB, free: 1.855 MB / 398.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.001545/0.5445, allocations: 0.8056 MB / 0.562 GB, free: 1.145 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.006254/0.5508, allocations: 2.319 MB / 0.5643 GB, free: 15.5 MB / 414.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01058/0.5614, allocations: 5.746 MB / 0.5699 GB, free: 11.24 MB / 414.1 MB
Notification: Performance of FrontEnd - DAE generated: time 7.875e-06/0.5614, allocations: 0 / 0.5699 GB, free: 11.24 MB / 414.1 MB
Notification: Performance of FrontEnd: time 1.964e-06/0.5614, allocations: 3.938 kB / 0.5699 GB, free: 11.23 MB / 414.1 MB
Notification: Performance of Transformations before backend: time 0.0001658/0.5615, allocations: 0 / 0.5699 GB, free: 11.23 MB / 414.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.02216/0.5837, allocations: 5.956 MB / 0.5757 GB, free: 5.203 MB / 414.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.68e-05/0.5838, allocations: 8.031 kB / 0.5757 GB, free: 5.195 MB / 414.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005229/0.589, allocations: 0.9352 MB / 0.5767 GB, free: 4.258 MB / 414.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006761/0.5958, allocations: 2.521 MB / 0.5791 GB, free: 1.668 MB / 414.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002129/0.596, allocations: 217.7 kB / 0.5793 GB, free: 1.453 MB / 414.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005308/0.5965, allocations: 300.1 kB / 0.5796 GB, free: 1.16 MB / 414.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00573/0.6022, allocations: 3.191 MB / 0.5827 GB, free: 13.57 MB / 430.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 5.92e-05/0.6023, allocations: 19.81 kB / 0.5827 GB, free: 13.55 MB / 430.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003124/0.6026, allocations: 123.9 kB / 0.5829 GB, free: 13.43 MB / 430.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.355e-05/0.6027, allocations: 76 kB / 0.5829 GB, free: 13.36 MB / 430.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004807/0.6075, allocations: 2.565 MB / 0.5854 GB, free: 10.78 MB / 430.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.03383/0.6413, allocations: 20.94 MB / 0.6059 GB, free: 4.828 MB / 446.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.004904/0.6462, allocations: 2.786 MB / 0.6086 GB, free: 1.879 MB / 446.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001469/0.6477, allocations: 0.8289 MB / 0.6094 GB, free: 1.051 MB / 446.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001268/0.6478, allocations: 42.3 kB / 0.6095 GB, free: 1.008 MB / 446.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.309e-05/0.6479, allocations: 68.81 kB / 0.6095 GB, free: 0.9297 MB / 446.1 MB
Notification: Performance of pre-optimization done (n=247): time 4.128e-06/0.6479, allocations: 4 kB / 0.6095 GB, free: 0.9258 MB / 446.1 MB
Notification: Performance of matching and sorting (n=247): time 0.01304/0.6609, allocations: 4.455 MB / 0.6139 GB, free: 12.4 MB / 462.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.546e-05/0.661, allocations: 99.42 kB / 0.614 GB, free: 12.29 MB / 462.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005259/0.6663, allocations: 2.971 MB / 0.6169 GB, free: 9.309 MB / 462.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0004543/0.6667, allocations: 85.7 kB / 0.617 GB, free: 9.219 MB / 462.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001588/0.6683, allocations: 1.511 MB / 0.6184 GB, free: 7.691 MB / 462.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001397/0.6697, allocations: 1.023 MB / 0.6194 GB, free: 6.66 MB / 462.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002356/0.6721, allocations: 1.421 MB / 0.6208 GB, free: 5.234 MB / 462.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001665/0.6722, allocations: 305.1 kB / 0.6211 GB, free: 4.934 MB / 462.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003912/0.6761, allocations: 2.089 MB / 0.6232 GB, free: 2.844 MB / 462.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004568/0.6807, allocations: 2.861 MB / 0.626 GB, free: 15.86 MB / 478.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007/0.6877, allocations: 4.086 MB / 0.6299 GB, free: 11.63 MB / 478.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.162e-05/0.6877, allocations: 4 kB / 0.6299 GB, free: 11.62 MB / 478.1 MB
Notification: Performance of matching and sorting (n=1011) (initialization): time 0.01482/0.7025, allocations: 6.999 MB / 0.6368 GB, free: 4.582 MB / 478.1 MB
Notification: Performance of prepare postOptimizeDAE: time 4.461e-05/0.7026, allocations: 8 kB / 0.6368 GB, free: 4.574 MB / 478.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.795e-05/0.7026, allocations: 11.94 kB / 0.6368 GB, free: 4.562 MB / 478.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009717/0.7123, allocations: 1.481 MB / 0.6382 GB, free: 3.051 MB / 478.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007181/0.7195, allocations: 1.564 MB / 0.6398 GB, free: 1.484 MB / 478.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0212/0.7407, allocations: 17.91 MB / 0.6573 GB, free: 14.17 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00719/0.7479, allocations: 0.5084 MB / 0.6578 GB, free: 13.66 MB / 0.4981 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0009716/0.7489, allocations: 256 kB / 0.658 GB, free: 13.41 MB / 0.4981 GB
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.002019/0.7509, allocations: 0.7386 MB / 0.6587 GB, free: 12.66 MB / 0.4981 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0009738/0.7519, allocations: 353.8 kB / 0.6591 GB, free: 12.31 MB / 0.4981 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00551/0.7574, allocations: 2.604 MB / 0.6616 GB, free: 9.691 MB / 0.4981 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.472e-05/0.7574, allocations: 11.95 kB / 0.6616 GB, free: 9.68 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.664e-06/0.7574, allocations: 4 kB / 0.6616 GB, free: 9.676 MB / 0.4981 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002211/0.7596, allocations: 0.7404 MB / 0.6623 GB, free: 8.914 MB / 0.4981 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005979/0.7602, allocations: 40 kB / 0.6624 GB, free: 8.875 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002381/0.7626, allocations: 119.8 kB / 0.6625 GB, free: 8.758 MB / 0.4981 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003675/0.763, allocations: 182 kB / 0.6627 GB, free: 8.574 MB / 0.4981 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.006219/0.7692, allocations: 2.638 MB / 0.6652 GB, free: 5.93 MB / 0.4981 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.005708/0.7749, allocations: 3.168 MB / 0.6683 GB, free: 2.727 MB / 0.4981 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001297/0.7762, allocations: 0.7361 MB / 0.6691 GB, free: 1.996 MB / 0.4981 GB
Notification: Performance of sorting global known variables: time 0.003489/0.7797, allocations: 1.794 MB / 0.6708 GB, free: 212 kB / 0.4981 GB
Notification: Performance of Backend: time 1.503e-06/0.7797, allocations: 0 / 0.6708 GB, free: 212 kB / 0.4981 GB
Notification: Performance of simCode: created initialization part: time 0.01405/0.7937, allocations: 5.437 MB / 0.6761 GB, free: 10.66 MB / 0.5137 GB
Notification: Performance of SimCode: time 0.01405/0.8078, allocations: 7.493 MB / 0.6834 GB, free: 3.137 MB / 0.5137 GB
Notification: Performance of Templates: time 0.4004/1.208, allocations: 122.1 MB / 0.8026 GB, free: 110.5 MB / 0.545 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]