Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerGrids_dev_PowerGrids.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo", uses=false)
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.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad,tolerance=1e-06,outputFormat="mat",numberOfIntervals=600,variableFilter="UMod.height|UMod.offset|UMod.startTime|UPhase.height|UPhase.offset|UPhase.startTime|bus1.PStart|bus1.QStart|bus1.R|bus1.SNom|bus1.UFixed|bus1.UNom|bus1.UPhaseStart|bus1.UStart|bus1.X|bus1.Z.im|bus1.Z.re|bus1.i.im|bus1.i.re|bus1.localInit|bus1.port.IBase|bus1.port.IStart|bus1.port.PStart|bus1.port.QStart|bus1.port.SBase|bus1.port.SNom|bus1.port.UBase|bus1.port.UNom|bus1.port.UPhaseStart|bus1.port.UStart|bus1.port.VBase|bus1.port.VStart|bus1.port.i.im|bus1.port.i.re|bus1.port.iStart.im|bus1.port.iStart.re|bus1.port.portVariablesPhases|bus1.port.v.im|bus1.port.v.re|bus1.port.vStart.im|bus1.port.vStart.re|bus1.portVariablesPhases|bus1.thetaFixed|bus1.useThetaIn|bus1.useUIn|bus1.v.im|bus1.v.re|load1.PRef|load1.PRefConst|load1.PStart|load1.QRef|load1.QRefConst|load1.QStart|load1.SNom|load1.UNom|load1.UPhaseStart|load1.URef|load1.UStart|load1.alpha|load1.beta|load1.localInit|load1.port.IBase|load1.port.IStart|load1.port.PStart|load1.port.QStart|load1.port.SBase|load1.port.SNom|load1.port.UBase|load1.port.UNom|load1.port.UPhaseStart|load1.port.UStart|load1.port.VBase|load1.port.VStart|load1.port.i.im|load1.port.i.re|load1.port.iStart.im|load1.port.iStart.re|load1.port.portVariablesPhases|load1.port.v.im|load1.port.v.re|load1.port.vStart.im|load1.port.vStart.re|load1.portVariablesPhases|systemPowerGrids.fNom|systemPowerGrids.initOpt|systemPowerGrids.omegaNom|systemPowerGrids.omegaRef|systemPowerGrids.referenceFrequency|time",fileNamePrefix="PowerGrids_dev_PowerGrids.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad")
translateModel(PowerGrids.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad,tolerance=1e-06,outputFormat="mat",numberOfIntervals=600,variableFilter="UMod.height|UMod.offset|UMod.startTime|UPhase.height|UPhase.offset|UPhase.startTime|bus1.PStart|bus1.QStart|bus1.R|bus1.SNom|bus1.UFixed|bus1.UNom|bus1.UPhaseStart|bus1.UStart|bus1.X|bus1.Z.im|bus1.Z.re|bus1.i.im|bus1.i.re|bus1.localInit|bus1.port.IBase|bus1.port.IStart|bus1.port.PStart|bus1.port.QStart|bus1.port.SBase|bus1.port.SNom|bus1.port.UBase|bus1.port.UNom|bus1.port.UPhaseStart|bus1.port.UStart|bus1.port.VBase|bus1.port.VStart|bus1.port.i.im|bus1.port.i.re|bus1.port.iStart.im|bus1.port.iStart.re|bus1.port.portVariablesPhases|bus1.port.v.im|bus1.port.v.re|bus1.port.vStart.im|bus1.port.vStart.re|bus1.portVariablesPhases|bus1.thetaFixed|bus1.useThetaIn|bus1.useUIn|bus1.v.im|bus1.v.re|load1.PRef|load1.PRefConst|load1.PStart|load1.QRef|load1.QRefConst|load1.QStart|load1.SNom|load1.UNom|load1.UPhaseStart|load1.URef|load1.UStart|load1.alpha|load1.beta|load1.localInit|load1.port.IBase|load1.port.IStart|load1.port.PStart|load1.port.QStart|load1.port.SBase|load1.port.SNom|load1.port.UBase|load1.port.UNom|load1.port.UPhaseStart|load1.port.UStart|load1.port.VBase|load1.port.VStart|load1.port.i.im|load1.port.i.re|load1.port.iStart.im|load1.port.iStart.re|load1.port.portVariablesPhases|load1.port.v.im|load1.port.v.re|load1.port.vStart.im|load1.port.vStart.re|load1.portVariablesPhases|systemPowerGrids.fNom|systemPowerGrids.initOpt|systemPowerGrids.omegaNom|systemPowerGrids.omegaRef|systemPowerGrids.referenceFrequency|time",fileNamePrefix="PowerGrids_dev_PowerGrids.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001606/0.001606, allocations: 103.5 kB / 16.4 MB, free: 6.461 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001628/0.001628, allocations: 189.7 kB / 17.34 MB, free: 5.719 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.375/1.375, allocations: 222.9 MB / 241 MB, free: 15.09 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo): time 0.07595/0.07595, allocations: 16.79 MB / 308 MB, free: 14.39 MB / 254.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001286/0.001286, allocations: 67.91 kB / 427.3 MB, free: 10.52 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1064/0.1077, allocations: 53.56 MB / 480.9 MB, free: 4.906 MB / 350.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 bus1.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 bus1.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 load1.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 load1.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.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad): time 0.0139/0.1216, allocations: 13.63 MB / 494.5 MB, free: 7.215 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.006387/0.128, allocations: 3.902 MB / 498.4 MB, free: 3.297 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001219/0.1293, allocations: 27.81 kB / 498.4 MB, free: 3.27 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001721/0.131, allocations: 0.5203 MB / 498.9 MB, free: 2.746 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.004267/0.1353, allocations: 1.742 MB / 0.4889 GB, free: 1.008 MB / 366.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001952/0.1373, allocations: 0.8694 MB / 0.4898 GB, free: 156 kB / 366.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0031/0.1404, allocations: 2.373 MB / 0.4921 GB, free: 13.77 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0007915/0.1412, allocations: 407.3 kB / 0.4925 GB, free: 13.36 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001246/0.1424, allocations: 0.8171 MB / 0.4933 GB, free: 12.54 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001325/0.1438, allocations: 0.7974 MB / 0.4941 GB, free: 11.74 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002894/0.1441, allocations: 108 kB / 0.4942 GB, free: 11.64 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00109/0.1452, allocations: 399.8 kB / 0.4946 GB, free: 11.25 MB / 382.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0003312/0.1455, allocations: 262.7 kB / 0.4948 GB, free: 10.99 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001188/0.1467, allocations: 0.754 MB / 0.4956 GB, free: 10.23 MB / 382.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.002557/0.1493, allocations: 1.904 MB / 0.4974 GB, free: 8.32 MB / 382.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.949e-06/0.1493, allocations: 0 / 0.4974 GB, free: 8.32 MB / 382.1 MB
Notification: Performance of FrontEnd: time 1.783e-06/0.1493, allocations: 0 / 0.4974 GB, free: 8.32 MB / 382.1 MB
Notification: Performance of Transformations before backend: time 6.379e-05/0.1494, allocations: 4 kB / 0.4974 GB, free: 8.316 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: 221
 * Number of variables: 221
Notification: Performance of Generate backend data structure: time 0.006396/0.1558, allocations: 2.1 MB / 0.4995 GB, free: 6.164 MB / 382.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.564e-05/0.1558, allocations: 8.031 kB / 0.4995 GB, free: 6.156 MB / 382.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001591/0.1574, allocations: 315.1 kB / 0.4998 GB, free: 5.848 MB / 382.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001615/0.1591, allocations: 0.9536 MB / 0.5007 GB, free: 4.852 MB / 382.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.531e-05/0.1591, allocations: 78.06 kB / 0.5008 GB, free: 4.773 MB / 382.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001096/0.1592, allocations: 84 kB / 0.5009 GB, free: 4.691 MB / 382.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001468/0.1607, allocations: 1.1 MB / 0.5019 GB, free: 3.453 MB / 382.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.549e-05/0.1608, allocations: 7.875 kB / 0.5019 GB, free: 3.445 MB / 382.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.301e-05/0.1608, allocations: 44 kB / 0.502 GB, free: 3.402 MB / 382.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.763e-05/0.1609, allocations: 27.98 kB / 0.502 GB, free: 3.375 MB / 382.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001229/0.1621, allocations: 0.7906 MB / 0.5028 GB, free: 2.582 MB / 382.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.2643/0.4264, allocations: 7.062 MB / 0.5097 GB, free: 29.25 MB / 382.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002002/0.4284, allocations: 0.9676 MB / 0.5106 GB, free: 29.01 MB / 382.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005116/0.4289, allocations: 292.5 kB / 0.5109 GB, free: 28.99 MB / 382.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 6.254e-05/0.429, allocations: 16.39 kB / 0.5109 GB, free: 28.99 MB / 382.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.111e-05/0.4291, allocations: 53.84 kB / 0.511 GB, free: 28.95 MB / 382.1 MB
Notification: Performance of pre-optimization done (n=81): time 3.868e-06/0.4291, allocations: 0 / 0.511 GB, free: 28.95 MB / 382.1 MB
Notification: Performance of matching and sorting (n=81): time 0.004603/0.4337, allocations: 1.557 MB / 0.5125 GB, free: 28.66 MB / 382.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.121e-05/0.4337, allocations: 85.02 kB / 0.5126 GB, free: 28.56 MB / 382.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001596/0.4353, allocations: 1.062 MB / 0.5136 GB, free: 28.12 MB / 382.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001038/0.4354, allocations: 46.75 kB / 0.5137 GB, free: 28.08 MB / 382.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0003985/0.4359, allocations: 0.5298 MB / 0.5142 GB, free: 27.74 MB / 382.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003177/0.4362, allocations: 331.2 kB / 0.5145 GB, free: 27.52 MB / 382.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006222/0.4368, allocations: 456 kB / 0.5149 GB, free: 27.3 MB / 382.1 MB
Notification: Performance of setup shared object (initialization): time 8.613e-05/0.4369, allocations: 354.6 kB / 0.5153 GB, free: 26.97 MB / 382.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00104/0.4379, allocations: 0.6405 MB / 0.5159 GB, free: 26.71 MB / 382.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00122/0.4392, allocations: 0.8571 MB / 0.5167 GB, free: 26.32 MB / 382.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001757/0.4409, allocations: 1.224 MB / 0.5179 GB, free: 25.66 MB / 382.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.003e-06/0.441, allocations: 3.562 kB / 0.5179 GB, free: 25.66 MB / 382.1 MB
Notification: Performance of matching and sorting (n=319) (initialization): time 0.004369/0.4453, allocations: 2.209 MB / 0.5201 GB, free: 24.72 MB / 382.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.623e-05/0.4454, allocations: 9.312 kB / 0.5201 GB, free: 24.72 MB / 382.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.329e-05/0.4454, allocations: 1.688 kB / 0.5201 GB, free: 24.72 MB / 382.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002451/0.4478, allocations: 417.1 kB / 0.5205 GB, free: 24.68 MB / 382.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002047/0.4499, allocations: 0.4955 MB / 0.521 GB, free: 24.63 MB / 382.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005373/0.4553, allocations: 4.401 MB / 0.5253 GB, free: 21.1 MB / 382.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002316/0.4576, allocations: 164.5 kB / 0.5254 GB, free: 20.99 MB / 382.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001671/0.4578, allocations: 82.28 kB / 0.5255 GB, free: 20.96 MB / 382.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 8
 * Number of states: 0 ()
 * Number of discrete variables: 2 (load1.componentPF.isSlackBus,bus1.componentPF.isSlackBus)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (301):
 * Single equations (assignments): 299
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(12,0), (8,0)}
Notification: Performance of prepare postOptimizeDAE: time 0.0006255/0.4584, allocations: 331 kB / 0.5258 GB, free: 20.7 MB / 382.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002703/0.4587, allocations: 118.6 kB / 0.5259 GB, free: 20.64 MB / 382.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002076/0.4608, allocations: 0.9469 MB / 0.5269 GB, free: 20.21 MB / 382.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.328e-05/0.4608, allocations: 4.078 kB / 0.5269 GB, free: 20.21 MB / 382.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.569e-06/0.4608, allocations: 3.938 kB / 0.5269 GB, free: 20.21 MB / 382.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005149/0.4614, allocations: 310.5 kB / 0.5272 GB, free: 19.97 MB / 382.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001326/0.4615, allocations: 11.8 kB / 0.5272 GB, free: 19.96 MB / 382.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008478/0.4623, allocations: 62.23 kB / 0.5272 GB, free: 19.94 MB / 382.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001563/0.4625, allocations: 72.31 kB / 0.5273 GB, free: 19.93 MB / 382.1 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002186/0.4647, allocations: 1.039 MB / 0.5283 GB, free: 19.45 MB / 382.1 MB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001608/0.4663, allocations: 1.213 MB / 0.5295 GB, free: 18.77 MB / 382.1 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0004506/0.4668, allocations: 267 kB / 0.5298 GB, free: 18.66 MB / 382.1 MB
Notification: Performance of sorting global known variables: time 0.000975/0.4678, allocations: 0.6754 MB / 0.5304 GB, free: 18.36 MB / 382.1 MB
Notification: Performance of Backend: time 4.11e-07/0.4678, allocations: 0 / 0.5304 GB, free: 18.36 MB / 382.1 MB
Notification: Performance of simCode: created initialization part: time 0.004143/0.4719, allocations: 1.921 MB / 0.5323 GB, free: 17.49 MB / 382.1 MB
Notification: Performance of SimCode: time 0.003298/0.4753, allocations: 3.185 MB / 0.5354 GB, free: 15.48 MB / 382.1 MB
Notification: Performance of Templates: time 0.02459/0.4999, allocations: 22.53 MB / 0.5574 GB, free: 11.43 MB / 398.1 MB
make -j1 -f PowerGrids_dev_PowerGrids.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad.makefile
(rm -f PowerGrids_dev_PowerGrids.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad.pipe ; mkfifo PowerGrids_dev_PowerGrids.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad.pipe ; head -c 1048576 < PowerGrids_dev_PowerGrids.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad.pipe >> ../files/PowerGrids_dev_PowerGrids.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad.sim & ./PowerGrids_dev_PowerGrids.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > PowerGrids_dev_PowerGrids.Electrical.Test.OneBusImpedanceVariableVoltageOneLoad.pipe 2>&1)