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.001652/0.001652, allocations: 109.9 kB / 16.41 MB, free: 6.48 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.001677/0.001677, allocations: 189.6 kB / 17.34 MB, free: 5.75 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.41/1.41, allocations: 222.9 MB / 241 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo): time 0.09165/0.09165, allocations: 16.79 MB / 308 MB, free: 14.41 MB / 254.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001381/0.001381, allocations: 67.89 kB / 427.3 MB, free: 10.53 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1186/0.12, allocations: 53.56 MB / 480.8 MB, free: 4.918 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.01516/0.1352, allocations: 13.64 MB / 494.5 MB, free: 7.219 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.007475/0.1427, allocations: 3.906 MB / 498.4 MB, free: 3.297 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001644/0.1443, allocations: 23.88 kB / 498.4 MB, free: 3.273 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.002079/0.1464, allocations: 0.5125 MB / 498.9 MB, free: 2.758 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.005107/0.1516, allocations: 1.679 MB / 0.4889 GB, free: 1.082 MB / 366.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00231/0.1539, allocations: 0.8627 MB / 0.4897 GB, free: 240 kB / 366.1 MB
Notification: Performance of NFFlatten.flatten: time 0.004007/0.1579, allocations: 2.364 MB / 0.492 GB, free: 13.87 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001014/0.1589, allocations: 415.3 kB / 0.4924 GB, free: 13.45 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001689/0.1606, allocations: 0.821 MB / 0.4932 GB, free: 12.62 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.00159/0.1622, allocations: 0.8051 MB / 0.494 GB, free: 11.82 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0004043/0.1627, allocations: 108 kB / 0.4941 GB, free: 11.71 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001555/0.1642, allocations: 391.8 kB / 0.4945 GB, free: 11.33 MB / 382.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004254/0.1647, allocations: 258.8 kB / 0.4947 GB, free: 11.07 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.00155/0.1662, allocations: 0.754 MB / 0.4955 GB, free: 10.32 MB / 382.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.00306/0.1693, allocations: 1.904 MB / 0.4973 GB, free: 8.406 MB / 382.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.54e-06/0.1693, allocations: 0 / 0.4973 GB, free: 8.406 MB / 382.1 MB
Notification: Performance of FrontEnd: time 1.723e-06/0.1693, allocations: 0 / 0.4973 GB, free: 8.406 MB / 382.1 MB
Notification: Performance of Transformations before backend: time 6.54e-05/0.1694, allocations: 0 / 0.4973 GB, free: 8.406 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.007174/0.1766, allocations: 2.1 MB / 0.4994 GB, free: 6.254 MB / 382.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.39e-05/0.1766, allocations: 12.03 kB / 0.4994 GB, free: 6.242 MB / 382.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001859/0.1785, allocations: 307.1 kB / 0.4997 GB, free: 5.941 MB / 382.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002054/0.1806, allocations: 0.9613 MB / 0.5006 GB, free: 4.938 MB / 382.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.268e-05/0.1807, allocations: 70.12 kB / 0.5007 GB, free: 4.867 MB / 382.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001634/0.1808, allocations: 95.98 kB / 0.5008 GB, free: 4.773 MB / 382.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001863/0.1827, allocations: 1.1 MB / 0.5019 GB, free: 3.535 MB / 382.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.081e-05/0.1827, allocations: 7.938 kB / 0.5019 GB, free: 3.527 MB / 382.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001114/0.1829, allocations: 40 kB / 0.5019 GB, free: 3.488 MB / 382.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.363e-05/0.1829, allocations: 24 kB / 0.5019 GB, free: 3.465 MB / 382.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001369/0.1843, allocations: 0.7906 MB / 0.5027 GB, free: 2.672 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.2913/0.4755, allocations: 7.06 MB / 0.5096 GB, free: 29.39 MB / 382.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001919/0.4775, allocations: 0.9653 MB / 0.5105 GB, free: 29.14 MB / 382.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004749/0.478, allocations: 298.8 kB / 0.5108 GB, free: 29.13 MB / 382.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 5.893e-05/0.478, allocations: 15.06 kB / 0.5108 GB, free: 29.13 MB / 382.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.155e-05/0.4781, allocations: 53.33 kB / 0.5109 GB, free: 29.09 MB / 382.1 MB
Notification: Performance of pre-optimization done (n=81): time 3.246e-06/0.4781, allocations: 1.969 kB / 0.5109 GB, free: 29.09 MB / 382.1 MB
Notification: Performance of matching and sorting (n=81): time 0.004302/0.4824, allocations: 1.556 MB / 0.5124 GB, free: 28.82 MB / 382.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.598e-05/0.4825, allocations: 87.7 kB / 0.5125 GB, free: 28.73 MB / 382.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001426/0.4839, allocations: 1.07 MB / 0.5135 GB, free: 28.28 MB / 382.1 MB
Notification: Performance of collectPreVariables (initialization): time 7.67e-05/0.484, allocations: 43.11 kB / 0.5136 GB, free: 28.24 MB / 382.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0003588/0.4843, allocations: 0.5246 MB / 0.5141 GB, free: 27.9 MB / 382.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003002/0.4846, allocations: 332.9 kB / 0.5144 GB, free: 27.68 MB / 382.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006237/0.4853, allocations: 456.8 kB / 0.5148 GB, free: 27.46 MB / 382.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001034/0.4854, allocations: 361.4 kB / 0.5152 GB, free: 27.13 MB / 382.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001036/0.4864, allocations: 0.6426 MB / 0.5158 GB, free: 26.87 MB / 382.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001153/0.4876, allocations: 0.8455 MB / 0.5166 GB, free: 26.48 MB / 382.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001788/0.4894, allocations: 1.235 MB / 0.5178 GB, free: 25.82 MB / 382.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.44e-06/0.4894, allocations: 0 / 0.5178 GB, free: 25.82 MB / 382.1 MB
Notification: Performance of matching and sorting (n=319) (initialization): time 0.004222/0.4936, allocations: 2.207 MB / 0.52 GB, free: 24.87 MB / 382.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.604e-05/0.4937, allocations: 6.781 kB / 0.52 GB, free: 24.87 MB / 382.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.181e-05/0.4937, allocations: 1.375 kB / 0.52 GB, free: 24.87 MB / 382.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002246/0.4959, allocations: 414.3 kB / 0.5204 GB, free: 24.83 MB / 382.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001866/0.4978, allocations: 0.4985 MB / 0.5209 GB, free: 24.78 MB / 382.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005384/0.5032, allocations: 4.405 MB / 0.5252 GB, free: 21.25 MB / 382.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001898/0.5051, allocations: 161 kB / 0.5253 GB, free: 21.14 MB / 382.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001385/0.5053, allocations: 78.12 kB / 0.5254 GB, free: 21.12 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.0005533/0.5058, allocations: 329.5 kB / 0.5257 GB, free: 20.86 MB / 382.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002336/0.5061, allocations: 123.5 kB / 0.5259 GB, free: 20.79 MB / 382.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002005/0.5081, allocations: 0.954 MB / 0.5268 GB, free: 20.36 MB / 382.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.25e-05/0.5081, allocations: 5.531 kB / 0.5268 GB, free: 20.36 MB / 382.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.316e-06/0.5081, allocations: 0 / 0.5268 GB, free: 20.36 MB / 382.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004503/0.5086, allocations: 313.1 kB / 0.5271 GB, free: 20.12 MB / 382.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000147/0.5087, allocations: 12.58 kB / 0.5271 GB, free: 20.11 MB / 382.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000841/0.5096, allocations: 54.78 kB / 0.5272 GB, free: 20.09 MB / 382.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001624/0.5097, allocations: 72.97 kB / 0.5272 GB, free: 20.08 MB / 382.1 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002243/0.512, allocations: 1.039 MB / 0.5282 GB, free: 19.6 MB / 382.1 MB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001515/0.5135, allocations: 1.204 MB / 0.5294 GB, free: 18.92 MB / 382.1 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0004069/0.5139, allocations: 268.4 kB / 0.5297 GB, free: 18.81 MB / 382.1 MB
Notification: Performance of sorting global known variables: time 0.0009791/0.5149, allocations: 0.6742 MB / 0.5303 GB, free: 18.51 MB / 382.1 MB
Notification: Performance of Backend: time 2e-07/0.5149, allocations: 4 kB / 0.5303 GB, free: 18.51 MB / 382.1 MB
Notification: Performance of simCode: created initialization part: time 0.004087/0.519, allocations: 1.921 MB / 0.5322 GB, free: 17.64 MB / 382.1 MB
Notification: Performance of SimCode: time 0.003518/0.5226, allocations: 3.18 MB / 0.5353 GB, free: 15.63 MB / 382.1 MB
Notification: Performance of Templates: time 0.02399/0.5466, allocations: 22.53 MB / 0.5573 GB, free: 11.54 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)