Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerSystems_master_PowerSystems.Examples.AC3ph.Transformation.TapChanger.conf.json
Using package PowerSystems with version 1.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 1.0.0-master/package.mo)
Using package ModelicaServices with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo)
Using package Modelica with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo)
Using package Complex with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo)
Running command: translateModel(PowerSystems.Examples.AC3ph.Transformation.TapChanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="PowerSystems_master_PowerSystems.Examples.AC3ph.Transformation.TapChanger")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo): time 0.002529/0.002537, allocations: 359.9 kB / 17.21 MB, free: 4.93 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo): time 3.748/3.748, allocations: 388.9 MB / 406.8 MB, free: 11.92 MB / 330.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo): time 0.00489/0.00489, allocations: 239.7 kB / 452.2 MB, free: 14.51 MB / 378.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 1.0.0-master/package.mo): time 0.7371/0.7371, allocations: 76 MB / 0.56 GB, free: 177.7 MB / 442.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000447/0.0004472, allocations: 12 kB / 0.6222 GB, free: 114.3 MB / 442.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08936/0.08983, allocations: 53.22 MB / 0.6742 GB, free: 60.97 MB / 442.7 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.AC3ph.Transformation.TapChanger): time 0.01089/0.1008, allocations: 9.585 MB / 0.6836 GB, free: 51.35 MB / 442.7 MB
Notification: Performance of NFInst.instExpressions: time 0.008166/0.109, allocations: 3.699 MB / 0.6872 GB, free: 47.64 MB / 442.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001295/0.1104, allocations: 67.5 kB / 0.6873 GB, free: 47.57 MB / 442.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001039/0.1114, allocations: 309.9 kB / 0.6875 GB, free: 47.27 MB / 442.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.003484/0.1149, allocations: 1.12 MB / 0.6886 GB, free: 46.14 MB / 442.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002435/0.1174, allocations: 0.6314 MB / 0.6893 GB, free: 45.51 MB / 442.7 MB
Notification: Performance of NFFlatten.flatten: time 0.003834/0.1213, allocations: 3.084 MB / 0.6923 GB, free: 42.42 MB / 442.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002333/0.1236, allocations: 1.112 MB / 0.6934 GB, free: 41.26 MB / 442.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001738/0.1254, allocations: 0.7972 MB / 0.6941 GB, free: 40.46 MB / 442.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002396/0.1278, allocations: 1.363 MB / 0.6955 GB, free: 39.09 MB / 442.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002946/0.1281, allocations: 68 kB / 0.6955 GB, free: 39.02 MB / 442.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001361/0.1295, allocations: 427.2 kB / 0.6959 GB, free: 38.61 MB / 442.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001281/0.1308, allocations: 0.8807 MB / 0.6968 GB, free: 37.72 MB / 442.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0006424/0.1315, allocations: 336.8 kB / 0.6971 GB, free: 37.39 MB / 442.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002662/0.1342, allocations: 1.742 MB / 0.6988 GB, free: 35.64 MB / 442.7 MB
Notification: Performance of FrontEnd - DAE generated: time 7.985e-06/0.1343, allocations: 0 / 0.6988 GB, free: 35.64 MB / 442.7 MB
Notification: Performance of FrontEnd: time 2.876e-06/0.1343, allocations: 0 / 0.6988 GB, free: 35.64 MB / 442.7 MB
Notification: Performance of Transformations before backend: time 8.298e-05/0.1344, allocations: 0 / 0.6988 GB, free: 35.64 MB / 442.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 423
 * Number of variables: 423
Notification: Performance of Generate backend data structure: time 0.004644/0.139, allocations: 1.715 MB / 0.7005 GB, free: 33.86 MB / 442.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.819e-05/0.1391, allocations: 11.97 kB / 0.7005 GB, free: 33.84 MB / 442.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002987/0.1421, allocations: 369.4 kB / 0.7009 GB, free: 33.48 MB / 442.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002751/0.1449, allocations: 0.9961 MB / 0.7018 GB, free: 32.44 MB / 442.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.925e-05/0.145, allocations: 106.7 kB / 0.7019 GB, free: 32.34 MB / 442.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005166/0.1456, allocations: 167.8 kB / 0.7021 GB, free: 32.17 MB / 442.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004703/0.1503, allocations: 2.304 MB / 0.7043 GB, free: 29.71 MB / 442.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 7.051e-05/0.1504, allocations: 7.938 kB / 0.7043 GB, free: 29.7 MB / 442.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001978/0.1506, allocations: 59.97 kB / 0.7044 GB, free: 29.64 MB / 442.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0008157/0.1515, allocations: 226.8 kB / 0.7046 GB, free: 29.42 MB / 442.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004502/0.156, allocations: 1.822 MB / 0.7064 GB, free: 27.59 MB / 442.7 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.01496/0.171, allocations: 9.556 MB / 0.7157 GB, free: 17.52 MB / 442.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.003275/0.1743, allocations: 1.533 MB / 0.7172 GB, free: 15.94 MB / 442.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001288/0.1757, allocations: 0.5903 MB / 0.7178 GB, free: 15.34 MB / 442.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001164/0.1758, allocations: 16.98 kB / 0.7178 GB, free: 15.33 MB / 442.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001518/0.1773, allocations: 0.8527 MB / 0.7187 GB, free: 14.43 MB / 442.7 MB
Notification: Performance of pre-optimization done (n=130): time 4.388e-06/0.1774, allocations: 0 / 0.7187 GB, free: 14.43 MB / 442.7 MB
Notification: Performance of matching and sorting (n=131): time 0.008305/0.1857, allocations: 3.945 MB / 0.7225 GB, free: 10.39 MB / 442.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.926e-05/0.1858, allocations: 282.3 kB / 0.7228 GB, free: 10.05 MB / 442.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001337/0.1872, allocations: 0.9187 MB / 0.7237 GB, free: 9.109 MB / 442.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001829/0.1874, allocations: 45.7 kB / 0.7237 GB, free: 9.059 MB / 442.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0005751/0.188, allocations: 0.7706 MB / 0.7245 GB, free: 8.273 MB / 442.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004629/0.1884, allocations: 445.7 kB / 0.7249 GB, free: 7.832 MB / 442.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001043/0.1886, allocations: 36 kB / 0.7249 GB, free: 7.797 MB / 442.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001722/0.1887, allocations: 434.7 kB / 0.7253 GB, free: 7.363 MB / 442.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001302/0.1901, allocations: 0.566 MB / 0.7259 GB, free: 6.797 MB / 442.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001579/0.1916, allocations: 1.159 MB / 0.727 GB, free: 5.375 MB / 442.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001914/0.1936, allocations: 0.8333 MB / 0.7278 GB, free: 4.527 MB / 442.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.831e-05/0.1937, allocations: 4 kB / 0.7278 GB, free: 4.523 MB / 442.7 MB
Notification: Performance of matching and sorting (n=227) (initialization): time 0.006768/0.2004, allocations: 2.466 MB / 0.7303 GB, free: 2.023 MB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 6.475e-05/0.2006, allocations: 67.66 kB / 0.7303 GB, free: 1.945 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.004404/0.205, allocations: 1.538 MB / 0.7318 GB, free: 404 kB / 442.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.2902/0.4953, allocations: 0.5482 MB / 0.7324 GB, free: 125.7 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002174/0.4975, allocations: 326.6 kB / 0.7327 GB, free: 125.7 MB / 442.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01476/0.5123, allocations: 8.685 MB / 0.7412 GB, free: 120.7 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001621/0.5139, allocations: 78.8 kB / 0.7412 GB, free: 120.7 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002358/0.5142, allocations: 99.69 kB / 0.7413 GB, free: 120.7 MB / 442.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 86
 * Number of states: 0 ()
 * Number of discrete variables: 21 (system.initime,$whenCondition3,$whenCondition4,$PRE.tapRelay1.cnt_1,tapRelay1.cnt_1,$PRE.tapRelay1.cnt_2,tapRelay1.cnt_2,$whenCondition1,$whenCondition2,$PRE.tapRelay2.cnt_1,tapRelay2.cnt_1,$PRE.tapRelay2.cnt_2,tapRelay2.cnt_2,$PRE.tapRelay2.tap_1,tapRelay2.tap_1,$PRE.tapRelay2.tap_2,tapRelay2.tap_2,$PRE.tapRelay1.tap_1,tapRelay1.tap_1,$PRE.tapRelay1.tap_2,tapRelay1.tap_2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (175):
 * Single equations (assignments): 169
 * 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: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 4 {(2,100.0%) 12,(2,100.0%) 11,(2,100.0%) 12,(2,100.0%) 11}
 * Non-linear torn systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0012/0.5154, allocations: 0.603 MB / 0.7419 GB, free: 120.5 MB / 442.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002755/0.5157, allocations: 124.5 kB / 0.742 GB, free: 120.5 MB / 442.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003734/0.5195, allocations: 1.513 MB / 0.7435 GB, free: 120.1 MB / 442.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.486e-05/0.5195, allocations: 9.5 kB / 0.7435 GB, free: 120.1 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.613e-06/0.5195, allocations: 1.031 kB / 0.7435 GB, free: 120.1 MB / 442.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007451/0.5203, allocations: 298 kB / 0.7438 GB, free: 120 MB / 442.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002302/0.5205, allocations: 30.8 kB / 0.7438 GB, free: 120 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009526/0.5215, allocations: 51.03 kB / 0.7439 GB, free: 120 MB / 442.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002504/0.5218, allocations: 74.58 kB / 0.7439 GB, free: 120 MB / 442.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.005629/0.5274, allocations: 1.977 MB / 0.7459 GB, free: 119.1 MB / 442.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.005272/0.5327, allocations: 2.531 MB / 0.7484 GB, free: 117.9 MB / 442.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001541/0.5343, allocations: 0.684 MB / 0.749 GB, free: 117.7 MB / 442.7 MB
Notification: Performance of sorting global known variables: time 0.001204/0.5356, allocations: 0.5947 MB / 0.7496 GB, free: 117.4 MB / 442.7 MB
Notification: Performance of Backend: time 6.61e-07/0.5356, allocations: 0 / 0.7496 GB, free: 117.4 MB / 442.7 MB
Notification: Performance of simCode: created initialization part: time 0.006077/0.5417, allocations: 1.981 MB / 0.7515 GB, free: 116.3 MB / 442.7 MB
Notification: Performance of SimCode: time 0.00969/0.5514, allocations: 4.143 MB / 0.7556 GB, free: 113.9 MB / 442.7 MB
Notification: Performance of Templates: time 0.0649/0.6164, allocations: 17.75 MB / 0.7729 GB, free: 110.5 MB / 442.7 MB