Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.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.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine,tolerance=1e-06,outputFormat="empty",numberOfIntervals=1000,variableFilter="",fileNamePrefix="PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine")
translateModel(PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine,tolerance=1e-06,outputFormat="empty",numberOfIntervals=1000,variableFilter="",fileNamePrefix="PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.007928/0.007928, allocations: 104.7 kB / 15.74 MB, free: 6.484 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.001456/0.001456, allocations: 193.5 kB / 16.67 MB, free: 6.375 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.472/1.472, allocations: 222.9 MB / 240.4 MB, free: 4.281 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo): time 0.2109/0.2109, allocations: 16.78 MB / 307.3 MB, free: 14.68 MB / 254.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001214/0.001214, allocations: 65.86 kB / 426.6 MB, free: 36.87 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1304/0.1316, allocations: 53.57 MB / 480.1 MB, free: 10.37 MB / 350.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/TwoPortACVI.mo:4:3-5:21:writable] Warning: Parameter line1.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 line1.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 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 bus2.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 bus2.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 line2.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 line2.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 bus3.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 bus3.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 bus4.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 bus4.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.HowToBuild.Examples.TestTransmissionLine): time 0.04517/0.1768, allocations: 53.79 MB / 0.5214 GB, free: 6.703 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.02062/0.1975, allocations: 10.75 MB / 0.5319 GB, free: 11.93 MB / 414.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.006562/0.2041, allocations: 87.62 kB / 0.532 GB, free: 11.85 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.006731/0.2109, allocations: 1.526 MB / 0.5335 GB, free: 10.31 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01573/0.2266, allocations: 4.772 MB / 0.5382 GB, free: 5.57 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005637/0.2323, allocations: 1.938 MB / 0.54 GB, free: 3.672 MB / 414.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01386/0.2462, allocations: 8.922 MB / 0.5488 GB, free: 10.73 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003823/0.25, allocations: 1.41 MB / 0.5501 GB, free: 9.273 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.006391/0.2564, allocations: 3.016 MB / 0.5531 GB, free: 6.246 MB / 430.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.006561/0.263, allocations: 3.19 MB / 0.5562 GB, free: 3.043 MB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001868/0.2649, allocations: 400 kB / 0.5566 GB, free: 2.652 MB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00508/0.27, allocations: 1.015 MB / 0.5576 GB, free: 1.637 MB / 430.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.001871/0.2719, allocations: 0.9216 MB / 0.5585 GB, free: 0.7109 MB / 430.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.006882/0.2788, allocations: 2.842 MB / 0.5612 GB, free: 13.86 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01403/0.2928, allocations: 7.08 MB / 0.5682 GB, free: 6.754 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 8.526e-06/0.2929, allocations: 4 kB / 0.5682 GB, free: 6.75 MB / 446.1 MB
Notification: Performance of FrontEnd: time 2.044e-06/0.2929, allocations: 3.938 kB / 0.5682 GB, free: 6.746 MB / 446.1 MB
Notification: Performance of Transformations before backend: time 0.0002488/0.2932, allocations: 0 / 0.5682 GB, free: 6.746 MB / 446.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 868
 * Number of variables: 868
Notification: Performance of Generate backend data structure: time 0.02841/0.3216, allocations: 7.161 MB / 0.5752 GB, free: 15.51 MB / 462.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.854e-05/0.3217, allocations: 8.031 kB / 0.5752 GB, free: 15.5 MB / 462.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007649/0.3293, allocations: 1.154 MB / 0.5763 GB, free: 14.34 MB / 462.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.008089/0.3374, allocations: 3.039 MB / 0.5793 GB, free: 11.23 MB / 462.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003337/0.3378, allocations: 266.8 kB / 0.5795 GB, free: 10.97 MB / 462.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0009962/0.3388, allocations: 355.9 kB / 0.5799 GB, free: 10.62 MB / 462.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.008781/0.3476, allocations: 3.935 MB / 0.5837 GB, free: 6.281 MB / 462.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001324/0.3477, allocations: 19.81 kB / 0.5837 GB, free: 6.262 MB / 462.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007195/0.3485, allocations: 156 kB / 0.5839 GB, free: 6.109 MB / 462.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001059/0.3486, allocations: 91.94 kB / 0.584 GB, free: 6.02 MB / 462.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007004/0.3556, allocations: 3.269 MB / 0.5871 GB, free: 2.75 MB / 462.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.3165/0.6721, allocations: 25.19 MB / 0.6117 GB, free: 86.56 MB / 462.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.007927/0.6801, allocations: 4.999 MB / 0.6166 GB, free: 83.32 MB / 462.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002019/0.6821, allocations: 1.306 MB / 0.6179 GB, free: 82.74 MB / 462.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.000181/0.6823, allocations: 45.7 kB / 0.6179 GB, free: 82.74 MB / 462.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.575e-05/0.6824, allocations: 73.94 kB / 0.618 GB, free: 82.68 MB / 462.1 MB
Notification: Performance of pre-optimization done (n=336): time 5.972e-06/0.6824, allocations: 3.609 kB / 0.618 GB, free: 82.68 MB / 462.1 MB
Notification: Performance of matching and sorting (n=336): time 0.01253/0.6949, allocations: 5.51 MB / 0.6234 GB, free: 80.06 MB / 462.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.706e-05/0.695, allocations: 167.2 kB / 0.6236 GB, free: 79.9 MB / 462.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004097/0.6991, allocations: 3.3 MB / 0.6268 GB, free: 78.12 MB / 462.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0003482/0.6995, allocations: 93.48 kB / 0.6269 GB, free: 78.04 MB / 462.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0008503/0.7003, allocations: 1.627 MB / 0.6285 GB, free: 76.79 MB / 462.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001031/0.7014, allocations: 1.331 MB / 0.6298 GB, free: 75.66 MB / 462.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001907/0.7033, allocations: 1.687 MB / 0.6314 GB, free: 74.66 MB / 462.1 MB
Notification: Performance of setup shared object (initialization): time 3.558e-05/0.7033, allocations: 301.1 kB / 0.6317 GB, free: 74.36 MB / 462.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003179/0.7065, allocations: 2.528 MB / 0.6342 GB, free: 73.06 MB / 462.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00385/0.7104, allocations: 3.277 MB / 0.6374 GB, free: 71.2 MB / 462.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005627/0.716, allocations: 4.793 MB / 0.642 GB, free: 67.23 MB / 462.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.682e-05/0.7161, allocations: 0 / 0.642 GB, free: 67.23 MB / 462.1 MB
Notification: Performance of matching and sorting (n=1218) (initialization): time 0.01182/0.7279, allocations: 8.082 MB / 0.6499 GB, free: 58.98 MB / 462.1 MB
Notification: Performance of prepare postOptimizeDAE: time 3.686e-05/0.728, allocations: 9.719 kB / 0.6499 GB, free: 58.98 MB / 462.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.643e-05/0.728, allocations: 4 kB / 0.65 GB, free: 58.97 MB / 462.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00311/0.7311, allocations: 0.7184 MB / 0.6507 GB, free: 58.24 MB / 462.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007512/0.7386, allocations: 1.963 MB / 0.6526 GB, free: 56.28 MB / 462.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01009/0.7487, allocations: 10.23 MB / 0.6626 GB, free: 45.52 MB / 462.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007296/0.7561, allocations: 0.5732 MB / 0.6631 GB, free: 44.94 MB / 462.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00097/0.7571, allocations: 292 kB / 0.6634 GB, free: 44.65 MB / 462.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 24
 * Number of states: 0 ()
 * Number of discrete variables: 4 (bus4.componentPF.isSlackBus,bus3.componentPF.isSlackBus,bus2.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 (1166):
 * Single equations (assignments): 1162
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(6,0,50.0%), (22,0,12.0%), (6,0,50.0%), (22,0,12.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.001977/0.759, allocations: 0.886 MB / 0.6643 GB, free: 43.76 MB / 462.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0009002/0.7599, allocations: 395.2 kB / 0.6646 GB, free: 43.37 MB / 462.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00473/0.7647, allocations: 3.289 MB / 0.6678 GB, free: 40.05 MB / 462.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.42e-05/0.7647, allocations: 15.94 kB / 0.6679 GB, free: 40.04 MB / 462.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.754e-06/0.7647, allocations: 4 kB / 0.6679 GB, free: 40.04 MB / 462.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.001739/0.7665, allocations: 0.8822 MB / 0.6687 GB, free: 39.13 MB / 462.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005041/0.767, allocations: 52 kB / 0.6688 GB, free: 39.08 MB / 462.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002762/0.7698, allocations: 147.8 kB / 0.6689 GB, free: 38.93 MB / 462.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003064/0.7701, allocations: 227 kB / 0.6691 GB, free: 38.71 MB / 462.1 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.006409/0.7765, allocations: 3.608 MB / 0.6727 GB, free: 35.15 MB / 462.1 MB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.005209/0.7817, allocations: 4.073 MB / 0.6766 GB, free: 31.02 MB / 462.1 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001184/0.7829, allocations: 1.026 MB / 0.6776 GB, free: 29.99 MB / 462.1 MB
Notification: Performance of sorting global known variables: time 0.002715/0.7857, allocations: 2.017 MB / 0.6796 GB, free: 27.98 MB / 462.1 MB
Notification: Performance of Backend: time 4.31e-07/0.7857, allocations: 0 / 0.6796 GB, free: 27.98 MB / 462.1 MB
Notification: Performance of simCode: created initialization part: time 0.01178/0.7975, allocations: 6.247 MB / 0.6857 GB, free: 21.75 MB / 462.1 MB
Notification: Performance of SimCode: time 0.01075/0.8082, allocations: 6.706 MB / 0.6923 GB, free: 15.05 MB / 462.1 MB
Notification: Performance of Templates: time 0.09583/0.9041, allocations: 58.73 MB / 0.7496 GB, free: 4.5 MB / 0.4981 GB
make -j1 -f PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.makefile
(rm -f PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.pipe ; mkfifo PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.pipe ; head -c 1048576 < PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.pipe >> ../files/PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.sim & ./PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine  -abortSlowSimulation -alarm=480 -lv LOG_STATS > PowerGrids_dev_PowerGrids.Examples.Tutorial.HowToBuild.Examples.TestTransmissionLine.pipe 2>&1)