Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Tests.ThreePhase.IEEE13.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo", uses=false)
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/Modelica 3.2.3+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/OpenIPSL 2.0.0/package.mo", uses=false)
Using package OpenIPSL with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/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 Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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)
Using package Modelica_Synchronous with version 0.93.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo)
Running command: translateModel(OpenIPSL.Tests.ThreePhase.IEEE13,tolerance=1e-06,outputFormat="empty",numberOfIntervals=20000,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Tests.ThreePhase.IEEE13")
translateModel(OpenIPSL.Tests.ThreePhase.IEEE13,tolerance=1e-06,outputFormat="empty",numberOfIntervals=20000,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Tests.ThreePhase.IEEE13")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo): time 0.1069/0.1069, allocations: 12.2 MB / 27.47 MB, free: 0.9297 MB / 19.63 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0007405/0.0007405, allocations: 103.5 kB / 31 MB, free: 4.527 MB / 26.18 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.499/1.499, allocations: 205.4 MB / 239.8 MB, free: 11.47 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001728/0.001728, allocations: 180.5 kB / 291 MB, free: 13.29 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo): time 0.4551/0.4551, allocations: 78.53 MB / 420.5 MB, free: 48.66 MB / 334.1 MB
Notification: Modelica_Synchronous 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: 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: OpenIPSL 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: Performance of FrontEnd - loaded program: time 0.0008319/0.0008319, allocations: 29.22 kB / 0.4901 GB, free: 2.273 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3558/0.3566, allocations: 69.23 MB / 0.5577 GB, free: 43.18 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.ThreePhase.IEEE13): time 0.01465/0.3714, allocations: 16.62 MB / 0.5739 GB, free: 33.05 MB / 430.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01367/0.3851, allocations: 5.581 MB / 0.5794 GB, free: 29.23 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005517/0.3906, allocations: 30.72 kB / 0.5794 GB, free: 29.22 MB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.002674/0.3933, allocations: 470.3 kB / 0.5799 GB, free: 29.04 MB / 430.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01778/0.4111, allocations: 5.834 MB / 0.5856 GB, free: 27.71 MB / 430.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002785/0.4139, allocations: 0.5697 MB / 0.5861 GB, free: 27.37 MB / 430.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01037/0.4243, allocations: 5.352 MB / 0.5913 GB, free: 25.14 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002579/0.427, allocations: 1.177 MB / 0.5925 GB, free: 24.52 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005517/0.4325, allocations: 2.304 MB / 0.5947 GB, free: 23.71 MB / 430.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.008724/0.4413, allocations: 5.358 MB / 0.6 GB, free: 22.34 MB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.004517/0.4458, allocations: 431.3 kB / 0.6004 GB, free: 22.33 MB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01667/0.4625, allocations: 11.5 MB / 0.6116 GB, free: 17.61 MB / 430.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.006406/0.469, allocations: 2.637 MB / 0.6142 GB, free: 15.97 MB / 430.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.01105/0.4801, allocations: 3.402 MB / 0.6175 GB, free: 13.33 MB / 430.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.02137/0.5015, allocations: 15.86 MB / 0.633 GB, free: 15.12 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.381e-06/0.5015, allocations: 4 kB / 0.633 GB, free: 15.12 MB / 446.1 MB
Notification: Performance of FrontEnd: time 2.155e-06/0.5015, allocations: 0 / 0.633 GB, free: 15.12 MB / 446.1 MB
Notification: Performance of Transformations before backend: time 0.000381/0.5019, allocations: 0 / 0.633 GB, free: 15.12 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: 1006
 * Number of variables: 1006
Notification: Performance of Generate backend data structure: time 0.02666/0.5286, allocations: 10.57 MB / 0.6433 GB, free: 4.453 MB / 446.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.197e-05/0.5286, allocations: 15.98 kB / 0.6434 GB, free: 4.438 MB / 446.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003304/0.5319, allocations: 0.78 MB / 0.6441 GB, free: 3.648 MB / 446.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01013/0.5421, allocations: 5.394 MB / 0.6494 GB, free: 14.18 MB / 462.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003643/0.5425, allocations: 408.4 kB / 0.6498 GB, free: 13.74 MB / 462.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001544/0.544, allocations: 292 kB / 0.65 GB, free: 13.45 MB / 462.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01625/0.5603, allocations: 7.926 MB / 0.6578 GB, free: 5.5 MB / 462.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 6.562e-05/0.5604, allocations: 0 / 0.6578 GB, free: 5.5 MB / 462.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0008406/0.5612, allocations: 123.9 kB / 0.6579 GB, free: 5.379 MB / 462.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000601/0.5619, allocations: 0.5034 MB / 0.6584 GB, free: 4.875 MB / 462.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02712/0.589, allocations: 14.31 MB / 0.6724 GB, free: 6.555 MB / 478.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.0679/0.6569, allocations: 31.59 MB / 0.7032 GB, free: 5.824 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0122/0.6692, allocations: 7.86 MB / 0.7109 GB, free: 13.73 MB / 0.5138 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.008427/0.6776, allocations: 4.941 MB / 0.7157 GB, free: 8.781 MB / 0.5138 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002219/0.6799, allocations: 1.987 MB / 0.7177 GB, free: 6.332 MB / 0.5138 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.929e-05/0.68, allocations: 77.52 kB / 0.7177 GB, free: 6.246 MB / 0.5138 GB
Notification: Performance of pre-optimization done (n=391): time 9.078e-06/0.68, allocations: 0 / 0.7177 GB, free: 6.246 MB / 0.5138 GB
Notification: Performance of matching and sorting (n=391): time 0.03711/0.7172, allocations: 17.56 MB / 0.7349 GB, free: 4.648 MB / 0.5294 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.44e-05/0.7173, allocations: 90.36 kB / 0.735 GB, free: 4.547 MB / 0.5294 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01871/0.736, allocations: 8.417 MB / 0.7432 GB, free: 12.15 MB / 0.545 GB
Notification: Performance of collectPreVariables (initialization): time 0.001444/0.7375, allocations: 85.7 kB / 0.7433 GB, free: 12.06 MB / 0.545 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004443/0.742, allocations: 3.057 MB / 0.7463 GB, free: 8.98 MB / 0.545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002915/0.7449, allocations: 1.344 MB / 0.7476 GB, free: 7.617 MB / 0.545 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00196/0.7469, allocations: 452.4 kB / 0.748 GB, free: 7.168 MB / 0.545 GB
Notification: Performance of setup shared object (initialization): time 0.0001208/0.747, allocations: 301.1 kB / 0.7483 GB, free: 6.871 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007969/0.755, allocations: 4.527 MB / 0.7527 GB, free: 2.336 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.009024/0.7641, allocations: 5.297 MB / 0.7579 GB, free: 12.77 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01941/0.7835, allocations: 9.738 MB / 0.7674 GB, free: 2.715 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.322e-05/0.7836, allocations: 4 kB / 0.7674 GB, free: 2.711 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=631) (initialization): time 0.2847/1.068, allocations: 15.15 MB / 0.7822 GB, free: 159 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 4.298e-05/1.068, allocations: 13.19 kB / 0.7822 GB, free: 159 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.766e-05/1.068, allocations: 18.78 kB / 0.7822 GB, free: 159 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.09464/1.163, allocations: 39.4 MB / 0.8207 GB, free: 148.6 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001933/1.165, allocations: 0.5236 MB / 0.8212 GB, free: 148.2 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02992/1.195, allocations: 16.78 MB / 0.8376 GB, free: 133.3 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006952/1.202, allocations: 0.5372 MB / 0.8381 GB, free: 132.8 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001399/1.203, allocations: 167.8 kB / 0.8383 GB, free: 132.7 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 81
 * Number of states: 0 ()
 * Number of discrete variables: 3 (breaker3.Open,breaker2.Open,breaker.Open)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (314):
 * Single equations (assignments): 313
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * 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): 1 system
   {(112,199)}
Notification: Performance of prepare postOptimizeDAE: time 0.005058/1.209, allocations: 1.756 MB / 0.84 GB, free: 130.9 MB / 0.5606 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00271/1.211, allocations: 0.6403 MB / 0.8406 GB, free: 130.2 MB / 0.5606 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03103/1.242, allocations: 15.58 MB / 0.8558 GB, free: 114.6 MB / 0.5606 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.396e-05/1.242, allocations: 67.98 kB / 0.8559 GB, free: 114.6 MB / 0.5606 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.137e-05/1.242, allocations: 0 / 0.8559 GB, free: 114.6 MB / 0.5606 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.356e-05/1.243, allocations: 19.92 kB / 0.8559 GB, free: 114.5 MB / 0.5606 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.04349/1.286, allocations: 22.84 MB / 0.8782 GB, free: 91.75 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.564e-05/1.286, allocations: 0 / 0.8782 GB, free: 91.75 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006579/1.287, allocations: 127.8 kB / 0.8783 GB, free: 91.62 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.08321/1.37, allocations: 26.51 MB / 0.9042 GB, free: 64.9 MB / 0.5606 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001364/1.371, allocations: 63.98 kB / 0.9043 GB, free: 64.84 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03591/1.407, allocations: 16.79 MB / 0.9207 GB, free: 47.98 MB / 0.5606 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.05e-06/1.407, allocations: 0 / 0.9207 GB, free: 47.98 MB / 0.5606 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02632/1.434, allocations: 14 MB / 0.9344 GB, free: 33.92 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002541/1.436, allocations: 1.05 MB / 0.9354 GB, free: 32.84 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002292/1.439, allocations: 64 kB / 0.9355 GB, free: 32.78 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00549/1.444, allocations: 279 kB / 0.9357 GB, free: 32.51 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001273/1.445, allocations: 182.7 kB / 0.9359 GB, free: 32.33 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0008868/1.446, allocations: 83.98 kB / 0.936 GB, free: 32.25 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.01024/1.457, allocations: 5.858 MB / 0.9417 GB, free: 26.41 MB / 0.5606 GB
Notification: Performance of sort global known variables: time 3.5e-07/1.457, allocations: 0 / 0.9417 GB, free: 26.41 MB / 0.5606 GB
Notification: Performance of remove unused functions: time 0.01192/1.469, allocations: 2.387 MB / 0.944 GB, free: 24.07 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 0 ()
 * Number of discrete variables: 3 (breaker.Open,breaker2.Open,breaker3.Open)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (74):
 * Single equations (assignments): 73
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * 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): 1 system
   {(114,197)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.006995/1.476, allocations: 0.5463 MB / 0.9446 GB, free: 23.6 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.0249/1.501, allocations: 12.61 MB / 0.9569 GB, free: 10.96 MB / 0.5606 GB
Notification: Performance of simCode: created event and clocks part: time 5.972e-06/1.501, allocations: 320 / 0.9569 GB, free: 10.96 MB / 0.5606 GB
Notification: Performance of simCode: created simulation system equations: time 0.01701/1.518, allocations: 7.31 MB / 0.964 GB, free: 3.648 MB / 0.5606 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.006783/1.524, allocations: 498.7 kB / 0.9645 GB, free: 3.156 MB / 0.5606 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03592/1.56, allocations: 17.54 MB / 0.9816 GB, free: 1.637 MB / 0.5763 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.005551/1.566, allocations: 3.669 MB / 0.9852 GB, free: 13.94 MB / 0.5919 GB
Notification: Performance of simCode: alias equations: time 0.002407/1.568, allocations: 0.7692 MB / 0.9859 GB, free: 13.16 MB / 0.5919 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001378/1.57, allocations: 271.4 kB / 0.9862 GB, free: 12.9 MB / 0.5919 GB
Notification: Performance of SimCode: time 7.91e-07/1.57, allocations: 0 / 0.9862 GB, free: 12.9 MB / 0.5919 GB
Notification: Performance of Templates: time 0.409/1.979, allocations: 136 MB / 1.119 GB, free: 97.01 MB / 0.5919 GB
make -j1 -f OpenIPSL_2.0.0_OpenIPSL.Tests.ThreePhase.IEEE13.makefile
Environment - environmentSimulation:
(rm -f OpenIPSL_2.0.0_OpenIPSL.Tests.ThreePhase.IEEE13.pipe ; mkfifo OpenIPSL_2.0.0_OpenIPSL.Tests.ThreePhase.IEEE13.pipe ; head -c 1048576 < OpenIPSL_2.0.0_OpenIPSL.Tests.ThreePhase.IEEE13.pipe >> ../files/OpenIPSL_2.0.0_OpenIPSL.Tests.ThreePhase.IEEE13.sim & ./OpenIPSL_2.0.0_OpenIPSL.Tests.ThreePhase.IEEE13  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_2.0.0_OpenIPSL.Tests.ThreePhase.IEEE13.pipe 2>&1)
Environment - environmentSimulation: