Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr PowerGrids_PowerGrids.Examples.ENTSOE.TestCase2.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.TestCase2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=1000,variableFilter="",fileNamePrefix="PowerGrids_PowerGrids.Examples.ENTSOE.TestCase2")
translateModel(PowerGrids.Examples.ENTSOE.TestCase2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=1000,variableFilter="",fileNamePrefix="PowerGrids_PowerGrids.Examples.ENTSOE.TestCase2")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001249/0.001249, allocations: 100.3 kB / 15.05 MB, free: 1.105 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.001639/0.001639, allocations: 177.3 kB / 15.94 MB, free: 228 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.607/1.607, allocations: 205.4 MB / 222.1 MB, free: 5.523 MB / 174.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.06344/0.06344, allocations: 14.16 MB / 284.5 MB, free: 7.016 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.0005633/0.0005637, allocations: 12 kB / 348.8 MB, free: 17.21 MB / 254.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1105/0.1111, allocations: 51.12 MB / 399.9 MB, free: 14.05 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Examples.ENTSOE.TestCase2): time 0.007292/0.1185, allocations: 7.075 MB / 407 MB, free: 6.938 MB / 302.1 MB
Notification: Performance of NFInst.instExpressions: time 0.006586/0.1251, allocations: 3.75 MB / 410.8 MB, free: 3.18 MB / 302.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0008133/0.1259, allocations: 31.81 kB / 410.8 MB, free: 3.148 MB / 302.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0007567/0.1267, allocations: 290.2 kB / 411.1 MB, free: 2.863 MB / 302.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.003001/0.1297, allocations: 1.3 MB / 412.4 MB, free: 1.562 MB / 302.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001436/0.1312, allocations: 0.6139 MB / 413 MB, free: 0.9531 MB / 302.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002444/0.1336, allocations: 1.632 MB / 414.6 MB, free: 15.32 MB / 318.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0004581/0.1341, allocations: 279.8 kB / 414.9 MB, free: 15.03 MB / 318.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0008439/0.1349, allocations: 0.6926 MB / 415.6 MB, free: 14.33 MB / 318.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.000754/0.1357, allocations: 0.7041 MB / 416.3 MB, free: 13.62 MB / 318.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001164/0.1358, allocations: 56 kB / 416.3 MB, free: 13.57 MB / 318.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0007125/0.1366, allocations: 299.7 kB / 416.6 MB, free: 13.28 MB / 318.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0001942/0.1368, allocations: 215 kB / 416.8 MB, free: 13.07 MB / 318.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0002251/0.137, allocations: 281 kB / 417.1 MB, free: 12.79 MB / 318.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.001389/0.1384, allocations: 1.496 MB / 418.6 MB, free: 11.29 MB / 318.1 MB
Notification: Performance of FrontEnd - DAE generated: time 2.805e-06/0.1384, allocations: 0 / 418.6 MB, free: 11.29 MB / 318.1 MB
Notification: Performance of FrontEnd: time 1.493e-06/0.1384, allocations: 4 kB / 418.6 MB, free: 11.28 MB / 318.1 MB
Notification: Performance of Transformations before backend: time 1.421e-05/0.1384, allocations: 0 / 418.6 MB, free: 11.28 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: 241
 * Number of variables: 241
Notification: Performance of Generate backend data structure: time 0.005071/0.1435, allocations: 1.964 MB / 420.6 MB, free: 9.262 MB / 318.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.792e-05/0.1436, allocations: 12.02 kB / 420.6 MB, free: 9.25 MB / 318.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0006089/0.1442, allocations: 198.1 kB / 420.8 MB, free: 9.055 MB / 318.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001581/0.1458, allocations: 0.9501 MB / 421.7 MB, free: 8.051 MB / 318.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.005e-05/0.1459, allocations: 86 kB / 421.8 MB, free: 7.965 MB / 318.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001714/0.146, allocations: 116 kB / 421.9 MB, free: 7.852 MB / 318.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001766/0.1478, allocations: 1.062 MB / 423 MB, free: 6.754 MB / 318.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.15e-05/0.1478, allocations: 0 / 423 MB, free: 6.754 MB / 318.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.991e-05/0.1479, allocations: 40 kB / 423 MB, free: 6.715 MB / 318.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.096e-05/0.148, allocations: 24 kB / 423.1 MB, free: 6.691 MB / 318.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001958/0.1499, allocations: 1.023 MB / 424.1 MB, free: 5.668 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.2184/0.3684, allocations: 5.492 MB / 429.6 MB, free: 35.54 MB / 318.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002552/0.371, allocations: 1.34 MB / 430.9 MB, free: 35.13 MB / 318.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 8.608e-05/0.3711, allocations: 18.17 kB / 430.9 MB, free: 35.13 MB / 318.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.187e-05/0.3711, allocations: 46.38 kB / 431 MB, free: 35.09 MB / 318.1 MB
Notification: Performance of pre-optimization done (n=106): time 3.086e-06/0.3712, allocations: 6.922 kB / 431 MB, free: 35.09 MB / 318.1 MB
Notification: Performance of matching and sorting (n=107): time 0.009724/0.3809, allocations: 3.434 MB / 434.4 MB, free: 34.52 MB / 318.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.244e-05/0.381, allocations: 141.5 kB / 434.6 MB, free: 34.37 MB / 318.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0014/0.3824, allocations: 0.9032 MB / 435.5 MB, free: 33.98 MB / 318.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001144/0.3825, allocations: 51.17 kB / 435.5 MB, free: 33.93 MB / 318.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0003673/0.3829, allocations: 0.5005 MB / 436 MB, free: 33.57 MB / 318.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003048/0.3832, allocations: 385.9 kB / 436.4 MB, free: 33.29 MB / 318.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 6.583e-05/0.3833, allocations: 33.94 kB / 436.4 MB, free: 33.26 MB / 318.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001176/0.3834, allocations: 363.4 kB / 436.8 MB, free: 32.93 MB / 318.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001022/0.3844, allocations: 0.5208 MB / 437.3 MB, free: 32.75 MB / 318.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001194/0.3856, allocations: 0.7437 MB / 438 MB, free: 32.35 MB / 318.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001127/0.3868, allocations: 0.6047 MB / 438.6 MB, free: 32.08 MB / 318.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.429e-06/0.3868, allocations: 3 kB / 438.6 MB, free: 32.08 MB / 318.1 MB
Notification: Performance of matching and sorting (n=187) (initialization): time 0.005701/0.3925, allocations: 2.219 MB / 440.9 MB, free: 31.25 MB / 318.1 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0003128/0.3928, allocations: 1.322 MB / 442.2 MB, free: 29.84 MB / 318.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.432e-05/0.3928, allocations: 3.438 kB / 442.2 MB, free: 29.84 MB / 318.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005804/0.3986, allocations: 1.064 MB / 443.3 MB, free: 29.66 MB / 318.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001617/0.4003, allocations: 337.7 kB / 443.6 MB, free: 29.63 MB / 318.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01401/0.4143, allocations: 16.64 MB / 460.2 MB, free: 14.39 MB / 318.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001534/0.4159, allocations: 95.53 kB / 460.3 MB, free: 14.36 MB / 318.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.804e-05/0.416, allocations: 51.44 kB / 460.4 MB, free: 14.35 MB / 318.1 MB
Notification: Performance of prepare postOptimizeDAE: time 1.061e-05/0.416, allocations: 11.89 kB / 460.4 MB, free: 14.34 MB / 318.1 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.003038/0.4191, allocations: 1.556 MB / 461.9 MB, free: 13.55 MB / 318.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.784e-06/0.4191, allocations: 3.969 kB / 461.9 MB, free: 13.55 MB / 318.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004697/0.4238, allocations: 0.9282 MB / 462.9 MB, free: 13.12 MB / 318.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001294/0.4251, allocations: 339.8 kB / 463.2 MB, free: 13.04 MB / 318.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007695/0.4328, allocations: 12.64 MB / 475.8 MB, free: 104 kB / 318.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001294/0.4341, allocations: 55.83 kB / 475.9 MB, free: 48 kB / 318.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001092/0.4342, allocations: 52.03 kB / 475.9 MB, free: 15.99 MB / 334.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 15
 * Number of states: 0 ()
 * Number of discrete variables: 2 (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 (165):
 * Single equations (assignments): 154
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 11
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 4 {(3,66.7%) 0,(2,100.0%) 0,(2,100.0%) 0,(3,66.7%) 0}
 * Non-linear torn systems: 7 {7 0,2 0,2 0,4 0,2 0,2 0,4 0}
Notification: Performance of prepare postOptimizeDAE: time 0.0008505/0.4351, allocations: 380.2 kB / 476.3 MB, free: 15.61 MB / 334.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002206/0.4353, allocations: 122.5 kB / 476.4 MB, free: 15.49 MB / 334.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002859/0.4382, allocations: 1.323 MB / 477.8 MB, free: 14.16 MB / 334.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.202e-05/0.4382, allocations: 7.984 kB / 477.8 MB, free: 14.16 MB / 334.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.46e-06/0.4382, allocations: 3.984 kB / 477.8 MB, free: 14.15 MB / 334.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004691/0.4387, allocations: 271.5 kB / 478 MB, free: 13.87 MB / 334.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001546/0.4389, allocations: 24 kB / 478.1 MB, free: 13.84 MB / 334.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007051/0.4396, allocations: 75.8 kB / 478.1 MB, free: 13.77 MB / 334.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001794/0.4398, allocations: 92.84 kB / 478.2 MB, free: 13.68 MB / 334.1 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.003386/0.4432, allocations: 1.369 MB / 479.6 MB, free: 12.32 MB / 334.1 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.002864/0.446, allocations: 1.687 MB / 481.3 MB, free: 10.62 MB / 334.1 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0008238/0.4469, allocations: 439.8 kB / 481.7 MB, free: 10.19 MB / 334.1 MB
Notification: Performance of sorting global known variables: time 0.0009903/0.4479, allocations: 0.5887 MB / 482.3 MB, free: 9.59 MB / 334.1 MB
Notification: Performance of Backend: time 8.82e-07/0.4479, allocations: 0 / 482.3 MB, free: 9.59 MB / 334.1 MB
Notification: Performance of simCode: created initialization part: time 0.008775/0.4567, allocations: 4.762 MB / 487.1 MB, free: 4.613 MB / 334.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.00507/0.4618, allocations: 3.491 MB / 490.5 MB, free: 1.102 MB / 334.1 MB
Notification: Performance of Templates: time 0.0398/0.5016, allocations: 23.92 MB / 0.5024 GB, free: 9.203 MB / 366.1 MB
make -j1 -f PowerGrids_PowerGrids.Examples.ENTSOE.TestCase2.makefile
Environment - environmentSimulation:
(rm -f PowerGrids_PowerGrids.Examples.ENTSOE.TestCase2.pipe ; mkfifo PowerGrids_PowerGrids.Examples.ENTSOE.TestCase2.pipe ; head -c 1048576 < PowerGrids_PowerGrids.Examples.ENTSOE.TestCase2.pipe >> ../files/PowerGrids_PowerGrids.Examples.ENTSOE.TestCase2.sim & ./PowerGrids_PowerGrids.Examples.ENTSOE.TestCase2  -nls=kinsol -lv=LOG_INIT_HOMOTOPY -abortSlowSimulation -alarm=480 -lv LOG_STATS > PowerGrids_PowerGrids.Examples.ENTSOE.TestCase2.pipe 2>&1)
Environment - environmentSimulation: