Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr PowerGrids_symb_jac_PowerGrids.Examples.ENTSOE.TestCase3.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 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo", uses=false)
Using package PowerGrids with version 1.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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)
Ignoring simflag  -noemit -homotopyOnFirstTry=() since it seems broken on HelloWorld
Running command: translateModel(PowerGrids.Examples.ENTSOE.TestCase3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=1000,variableFilter="",fileNamePrefix="PowerGrids_symb_jac_PowerGrids.Examples.ENTSOE.TestCase3")
translateModel(PowerGrids.Examples.ENTSOE.TestCase3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=1000,variableFilter="",fileNamePrefix="PowerGrids_symb_jac_PowerGrids.Examples.ENTSOE.TestCase3")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001144/0.001144, allocations: 96.42 kB / 15.69 MB, free: 480 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001758/0.001758, allocations: 177.7 kB / 16.57 MB, free: 6.391 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.667/1.667, allocations: 205.4 MB / 222.7 MB, free: 5.664 MB / 174.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.05983/0.05983, allocations: 14.15 MB / 285.2 MB, free: 7.172 MB / 238.1 MB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.0005161/0.0005163, allocations: 12 kB / 349.5 MB, free: 17.23 MB / 254.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1111/0.1116, allocations: 51.11 MB / 400.6 MB, free: 14.07 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Examples.ENTSOE.TestCase3): time 0.01508/0.1267, allocations: 13.62 MB / 414.2 MB, free: 400 kB / 302.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01392/0.1407, allocations: 6.427 MB / 420.6 MB, free: 9.949 MB / 318.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004363/0.1451, allocations: 67.56 kB / 420.7 MB, free: 9.883 MB / 318.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.003539/0.1487, allocations: 0.555 MB / 421.2 MB, free: 9.324 MB / 318.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.00905/0.1578, allocations: 2.271 MB / 423.5 MB, free: 7.059 MB / 318.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003868/0.1617, allocations: 1.145 MB / 424.7 MB, free: 5.918 MB / 318.1 MB
Notification: Performance of NFFlatten.flatten: time 0.008488/0.1702, allocations: 3.39 MB / 428 MB, free: 2.523 MB / 318.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002001/0.1722, allocations: 0.6165 MB / 428.7 MB, free: 1.867 MB / 318.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003731/0.176, allocations: 1.331 MB / 430 MB, free: 0.5312 MB / 318.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.2357/0.4117, allocations: 1.359 MB / 431.4 MB, free: 14.48 MB / 318.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0008332/0.4125, allocations: 92.56 kB / 431.4 MB, free: 14.48 MB / 318.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002408/0.415, allocations: 452 kB / 431.9 MB, free: 14.48 MB / 318.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004349/0.4154, allocations: 391.5 kB / 432.3 MB, free: 14.48 MB / 318.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001304/0.4167, allocations: 0.5427 MB / 432.8 MB, free: 14.45 MB / 318.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.00534/0.4221, allocations: 2.883 MB / 435.7 MB, free: 14.23 MB / 318.1 MB
Notification: Performance of FrontEnd - DAE generated: time 3.135e-06/0.4221, allocations: 0 / 435.7 MB, free: 14.23 MB / 318.1 MB
Notification: Performance of FrontEnd: time 4.458e-06/0.4221, allocations: 1.375 kB / 435.7 MB, free: 14.23 MB / 318.1 MB
Notification: Performance of Transformations before backend: time 0.000137/0.4223, allocations: 0 / 435.7 MB, free: 14.23 MB / 318.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 517
 * Number of variables: 517
Notification: Performance of Generate backend data structure: time 0.01301/0.4353, allocations: 3.677 MB / 439.4 MB, free: 12.8 MB / 318.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.038e-05/0.4353, allocations: 11.64 kB / 439.4 MB, free: 12.8 MB / 318.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002417/0.4378, allocations: 429.2 kB / 439.8 MB, free: 12.64 MB / 318.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004397/0.4422, allocations: 1.721 MB / 441.5 MB, free: 12.15 MB / 318.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001311/0.4423, allocations: 165.3 kB / 441.7 MB, free: 12.14 MB / 318.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003809/0.4427, allocations: 230 kB / 441.9 MB, free: 12.14 MB / 318.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004119/0.4468, allocations: 2.124 MB / 444 MB, free: 11.82 MB / 318.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.861e-05/0.4469, allocations: 5.25 kB / 444 MB, free: 11.82 MB / 318.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001738/0.4471, allocations: 86.5 kB / 444.1 MB, free: 11.82 MB / 318.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.336e-05/0.4471, allocations: 53.12 kB / 444.2 MB, free: 11.82 MB / 318.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003776/0.4509, allocations: 2.001 MB / 446.2 MB, free: 11.8 MB / 318.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.01574/0.4667, allocations: 11.73 MB / 457.9 MB, free: 3.574 MB / 318.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.004112/0.4708, allocations: 2.811 MB / 460.7 MB, free: 2.348 MB / 318.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001043/0.471, allocations: 32.44 kB / 460.7 MB, free: 2.344 MB / 318.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001743/0.4727, allocations: 1.124 MB / 461.9 MB, free: 1.922 MB / 318.1 MB
Notification: Performance of pre-optimization done (n=213): time 4.078e-06/0.4727, allocations: 0 / 461.9 MB, free: 1.922 MB / 318.1 MB
Notification: Performance of matching and sorting (n=214): time 0.01491/0.4876, allocations: 6.391 MB / 468.3 MB, free: 15.76 MB / 334.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002015/0.4879, allocations: 375.5 kB / 468.6 MB, free: 15.35 MB / 334.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00265/0.4905, allocations: 1.68 MB / 470.3 MB, free: 14.21 MB / 334.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0002407/0.4908, allocations: 71.83 kB / 470.4 MB, free: 14.17 MB / 334.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0008772/0.4917, allocations: 1.065 MB / 471.4 MB, free: 13.53 MB / 334.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0008357/0.4925, allocations: 0.7353 MB / 472.2 MB, free: 12.86 MB / 334.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001219/0.4927, allocations: 56 kB / 472.2 MB, free: 12.8 MB / 334.1 MB
Notification: Performance of setup shared object (initialization): time 0.0002174/0.4929, allocations: 407.5 kB / 472.6 MB, free: 12.4 MB / 334.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001614/0.4945, allocations: 0.833 MB / 473.5 MB, free: 11.57 MB / 334.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002057/0.4966, allocations: 1.387 MB / 474.9 MB, free: 9.977 MB / 334.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001884/0.4985, allocations: 1.062 MB / 475.9 MB, free: 8.898 MB / 334.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.805e-06/0.4985, allocations: 4 kB / 475.9 MB, free: 8.895 MB / 334.1 MB
Notification: Performance of matching and sorting (n=343) (initialization): time 0.008422/0.5069, allocations: 3.775 MB / 479.7 MB, free: 5.129 MB / 334.1 MB
Notification: Performance of prepare postOptimizeDAE: time 0.001982/0.5089, allocations: 5.05 MB / 484.7 MB, free: 15.68 MB / 350.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.496e-05/0.509, allocations: 12 kB / 484.8 MB, free: 15.67 MB / 350.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007842/0.5168, allocations: 1.63 MB / 486.4 MB, free: 14.01 MB / 350.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002394/0.5192, allocations: 0.5329 MB / 486.9 MB, free: 13.51 MB / 350.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02574/0.545, allocations: 21.11 MB / 0.4961 GB, free: 6.906 MB / 366.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003693/0.5487, allocations: 159.5 kB / 0.4963 GB, free: 6.75 MB / 366.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002712/0.549, allocations: 106.9 kB / 0.4964 GB, free: 6.648 MB / 366.1 MB
Notification: Performance of prepare postOptimizeDAE: time 1.112e-05/0.549, allocations: 4 kB / 0.4964 GB, free: 6.645 MB / 366.1 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.006056/0.5551, allocations: 2.874 MB / 0.4992 GB, free: 3.797 MB / 366.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.431e-05/0.5552, allocations: 12 kB / 0.4992 GB, free: 3.785 MB / 366.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007487/0.5627, allocations: 1.453 MB / 0.5006 GB, free: 2.301 MB / 366.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003541/0.5662, allocations: 0.5341 MB / 0.5011 GB, free: 1.797 MB / 366.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0242/0.5905, allocations: 17.74 MB / 0.5185 GB, free: 14.7 MB / 398.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002916/0.5934, allocations: 111.7 kB / 0.5186 GB, free: 14.59 MB / 398.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002126/0.5937, allocations: 95.98 kB / 0.5187 GB, free: 14.49 MB / 398.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 55
 * Number of states: 0 ()
 * Number of discrete variables: 15 ($whenCondition3,$whenCondition4,$PRE.NTHV.fault,NTHV.fault,$whenCondition1,$whenCondition2,$PRE.NTHV.Y.re,NTHV.Y.re,$PRE.NTHV.Y.im,NTHV.Y.im,PSS.firstWashoutVsi2.integrator.local_reset,PSS.secondWashoutVsi1.integrator.local_reset,PSS.firstWashoutVsi1.integrator.local_reset,AVR.firstOrderLim.I.local_reset,TGOV.firstOrderLim.I.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (288):
 * Single equations (assignments): 274
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 12
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 6 {(3,66.7%) 0,(2,100.0%) 0,(2,100.0%) 0,(3,66.7%) 0,(3,66.7%) 0,(2,100.0%) 0}
 * Non-linear torn systems: 6 {38 0,2 0,2 0,2 0,2 0,4 0}
Notification: Performance of prepare postOptimizeDAE: time 0.001565/0.5952, allocations: 0.6327 MB / 0.5193 GB, free: 13.87 MB / 398.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006056/0.5959, allocations: 245 kB / 0.5195 GB, free: 13.62 MB / 398.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004714/0.6006, allocations: 2.428 MB / 0.5219 GB, free: 11.2 MB / 398.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.057e-05/0.6006, allocations: 11.95 kB / 0.5219 GB, free: 11.18 MB / 398.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.951e-06/0.6006, allocations: 3.938 kB / 0.5219 GB, free: 11.18 MB / 398.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.00132/0.602, allocations: 466 kB / 0.5223 GB, free: 10.7 MB / 398.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003251/0.6023, allocations: 44 kB / 0.5224 GB, free: 10.66 MB / 398.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001254/0.6035, allocations: 111.7 kB / 0.5225 GB, free: 10.55 MB / 398.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002782/0.6038, allocations: 169.7 kB / 0.5227 GB, free: 10.38 MB / 398.1 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.005608/0.6095, allocations: 2.514 MB / 0.5251 GB, free: 7.867 MB / 398.1 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.005034/0.6145, allocations: 2.985 MB / 0.528 GB, free: 4.844 MB / 398.1 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001296/0.6158, allocations: 0.7887 MB / 0.5288 GB, free: 4.059 MB / 398.1 MB
Notification: Performance of sorting global known variables: time 0.001937/0.6178, allocations: 1.083 MB / 0.5299 GB, free: 2.957 MB / 398.1 MB
Notification: Performance of Backend: time 1.884e-06/0.6178, allocations: 4 kB / 0.5299 GB, free: 2.953 MB / 398.1 MB
Notification: Performance of simCode: created initialization part: time 0.01578/0.6336, allocations: 7.51 MB / 0.5372 GB, free: 11.23 MB / 414.1 MB
Warning: The hideResult annotation could not be evaluated, probably due to missing annotation(Evaluate=true). It is set to 'isProtected' (=false) by default.
Notification: Performance of SimCode: time 0.01165/0.6453, allocations: 6.247 MB / 0.5433 GB, free: 4.938 MB / 414.1 MB
Notification: Performance of Templates: time 0.08293/0.7282, allocations: 43.39 MB / 0.5857 GB, free: 9.645 MB / 462.1 MB
make -j1 -f PowerGrids_symb_jac_PowerGrids.Examples.ENTSOE.TestCase3.makefile
Environment - environmentSimulation:
(rm -f PowerGrids_symb_jac_PowerGrids.Examples.ENTSOE.TestCase3.pipe ; mkfifo PowerGrids_symb_jac_PowerGrids.Examples.ENTSOE.TestCase3.pipe ; head -c 1048576 < PowerGrids_symb_jac_PowerGrids.Examples.ENTSOE.TestCase3.pipe >> ../files/PowerGrids_symb_jac_PowerGrids.Examples.ENTSOE.TestCase3.sim & ./PowerGrids_symb_jac_PowerGrids.Examples.ENTSOE.TestCase3  -nls=kinsol -lv=LOG_INIT_HOMOTOPY -abortSlowSimulation -alarm=480 -lv LOG_STATS > PowerGrids_symb_jac_PowerGrids.Examples.ENTSOE.TestCase3.pipe 2>&1)
Environment - environmentSimulation: