Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.1-maint.9.1.x/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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
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 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 Buildings with version 9.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.1-maint.9.1.x/package.mo)
Running command: translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|err_V2.1.|err_V2.2.|err_V2.3.|err_V3.1.|err_V3.2.|err_V3.3.|err_V4.1.|err_V4.2.|err_V4.3.|err_Theta2.1.|err_Theta2.2.|err_Theta2.3.|err_Theta3.1.|err_Theta3.2.|err_Theta3.3.|err_Theta4.1.|err_Theta4.2.|err_Theta4.3.",fileNamePrefix="Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY")
translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|err_V2.1.|err_V2.2.|err_V2.3.|err_V3.1.|err_V3.2.|err_V3.3.|err_V4.1.|err_V4.2.|err_V4.3.|err_Theta2.1.|err_Theta2.2.|err_Theta2.3.|err_Theta3.1.|err_Theta3.2.|err_Theta3.3.|err_Theta4.1.|err_Theta4.2.|err_Theta4.3.",fileNamePrefix="Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.1-maint.9.1.x/package.mo): time 2.318/2.318, allocations: 390.3 MB / 405.3 MB, free: 13.47 MB / 314.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001739/0.001739, allocations: 190.9 kB / 498.1 MB, free: 5.727 MB / 394.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.829/1.829, allocations: 223.2 MB / 0.7948 GB, free: 17.89 MB / 0.5573 GB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001271/0.001271, allocations: 100.3 kB / 0.9346 GB, free: 6.184 MB / 0.6823 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004311/0.0004316, allocations: 6.938 kB / 1.084 GB, free: 221.4 MB / 0.823 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3673/0.3677, allocations: 142.3 MB / 1.223 GB, free: 114.2 MB / 0.823 GB
Notification: Performance of FrontEnd - scodeFlatten: time 1.213/1.581, allocations: 211.1 MB / 1.429 GB, free: 95.34 MB / 0.9167 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0004781/1.582, allocations: 121.2 kB / 1.429 GB, free: 95.34 MB / 0.9167 GB
Notification: Performance of FrontEnd - DAE generated: time 0.4019/1.983, allocations: 159 MB / 1.584 GB, free: 45.03 MB / 0.9167 GB
Notification: Performance of FrontEnd: time 3.577e-06/1.984, allocations: 0 / 1.584 GB, free: 45.03 MB / 0.9167 GB
Notification: Performance of Transformations before backend: time 0.0002248/1.984, allocations: 72 kB / 1.584 GB, free: 44.96 MB / 0.9167 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1023
 * Number of variables: 1023
Notification: Performance of Generate backend data structure: time 0.01703/2.001, allocations: 3.186 MB / 1.588 GB, free: 41.88 MB / 0.9167 GB
Notification: Performance of prepare preOptimizeDAE: time 6.693e-05/2.001, allocations: 8.031 kB / 1.588 GB, free: 41.88 MB / 0.9167 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01524/2.016, allocations: 2.133 MB / 1.59 GB, free: 39.73 MB / 0.9167 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.008618/2.025, allocations: 2.252 MB / 1.592 GB, free: 37.44 MB / 0.9167 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003699/2.025, allocations: 279.4 kB / 1.592 GB, free: 37.16 MB / 0.9167 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003162/2.028, allocations: 359.9 kB / 1.592 GB, free: 36.81 MB / 0.9167 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02774/2.056, allocations: 6.679 MB / 1.599 GB, free: 30.01 MB / 0.9167 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003289/2.057, allocations: 11.88 kB / 1.599 GB, free: 30 MB / 0.9167 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003159/2.06, allocations: 156 kB / 1.599 GB, free: 29.84 MB / 0.9167 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0008296/2.061, allocations: 306.2 kB / 1.599 GB, free: 29.54 MB / 0.9167 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02071/2.081, allocations: 6.518 MB / 1.606 GB, free: 23.02 MB / 0.9167 GB
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.05421/2.136, allocations: 28.23 MB / 1.633 GB, free: 8.383 MB / 0.9323 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01013/2.146, allocations: 4.247 MB / 1.638 GB, free: 3.926 MB / 0.9323 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004772/2.146, allocations: 135 kB / 1.638 GB, free: 3.777 MB / 0.9323 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.86e-05/2.147, allocations: 68.44 kB / 1.638 GB, free: 3.703 MB / 0.9323 GB
Notification: Performance of pre-optimization done (n=198): time 9.769e-06/2.147, allocations: 0 / 1.638 GB, free: 3.703 MB / 0.9323 GB
Notification: Performance of matching and sorting (n=255): time 0.1055/2.252, allocations: 28.41 MB / 1.665 GB, free: 7.242 MB / 0.9636 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000172/2.252, allocations: 243.5 kB / 1.666 GB, free: 6.957 MB / 0.9636 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002706/2.255, allocations: 1.285 MB / 1.667 GB, free: 5.664 MB / 0.9636 GB
Notification: Performance of collectPreVariables (initialization): time 0.0008573/2.256, allocations: 73.7 kB / 1.667 GB, free: 5.586 MB / 0.9636 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001267/2.257, allocations: 1.551 MB / 1.669 GB, free: 4.012 MB / 0.9636 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001392/2.259, allocations: 0.8704 MB / 1.669 GB, free: 3.129 MB / 0.9636 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002348/2.259, allocations: 60 kB / 1.669 GB, free: 3.07 MB / 0.9636 GB
Notification: Performance of setup shared object (initialization): time 0.0002838/2.259, allocations: 436.4 kB / 1.67 GB, free: 2.637 MB / 0.9636 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005694/2.265, allocations: 2.535 MB / 1.672 GB, free: 100 kB / 0.9636 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006682/2.271, allocations: 3.427 MB / 1.676 GB, free: 12.28 MB / 0.9792 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006487/2.278, allocations: 2.973 MB / 1.679 GB, free: 9.281 MB / 0.9792 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.127e-05/2.278, allocations: 8 kB / 1.679 GB, free: 9.273 MB / 0.9792 GB
Notification: Performance of matching and sorting (n=396) (initialization): time 0.02285/2.301, allocations: 8.836 MB / 1.687 GB, free: 380 kB / 0.9792 GB
Notification: Performance of prepare postOptimizeDAE: time 0.005066/2.306, allocations: 10.79 MB / 1.698 GB, free: 4.723 MB / 0.9948 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.557e-05/2.306, allocations: 28 kB / 1.698 GB, free: 4.695 MB / 0.9948 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02777/2.334, allocations: 6.655 MB / 1.704 GB, free: 14.02 MB / 1.01 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004598/2.339, allocations: 0.8737 MB / 1.705 GB, free: 13.15 MB / 1.01 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02355/2.362, allocations: 14.05 MB / 1.719 GB, free: 14.93 MB / 1.026 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005413/2.368, allocations: 0.5223 MB / 1.719 GB, free: 14.4 MB / 1.026 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001015/2.369, allocations: 187.9 kB / 1.72 GB, free: 14.22 MB / 1.026 GB
Notification: Performance of prepare postOptimizeDAE: time 2.166e-05/2.369, allocations: 4 kB / 1.72 GB, free: 14.21 MB / 1.026 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.02146/2.39, allocations: 8.116 MB / 1.727 GB, free: 6.043 MB / 1.026 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001622/2.39, allocations: 31.94 kB / 1.728 GB, free: 6.012 MB / 1.026 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01284/2.403, allocations: 3.205 MB / 1.731 GB, free: 2.801 MB / 1.026 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00591/2.409, allocations: 1.057 MB / 1.732 GB, free: 1.742 MB / 1.026 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02039/2.43, allocations: 11.53 MB / 1.743 GB, free: 6.07 MB / 1.042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004935/2.435, allocations: 0.4952 MB / 1.743 GB, free: 5.574 MB / 1.042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001347/2.436, allocations: 195.9 kB / 1.744 GB, free: 5.383 MB / 1.042 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 124
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (302):
 * Single equations (assignments): 300
 * 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: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(6,100.0%) 42}
 * Non-linear torn systems: 1 {6 42}
Notification: Performance of prepare postOptimizeDAE: time 0.00598/2.442, allocations: 1.62 MB / 1.745 GB, free: 3.75 MB / 1.042 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001314/2.443, allocations: 193.7 kB / 1.745 GB, free: 3.559 MB / 1.042 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0233/2.467, allocations: 8.568 MB / 1.754 GB, free: 10.94 MB / 1.057 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.055e-05/2.467, allocations: 27.98 kB / 1.754 GB, free: 10.91 MB / 1.057 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.579e-05/2.467, allocations: 12 kB / 1.754 GB, free: 10.9 MB / 1.057 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 8.489e-05/2.467, allocations: 11.95 kB / 1.754 GB, free: 10.89 MB / 1.057 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.04126/2.508, allocations: 13.66 MB / 1.767 GB, free: 13.05 MB / 1.073 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.995e-05/2.508, allocations: 8 kB / 1.767 GB, free: 13.05 MB / 1.073 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003407/2.512, allocations: 0.6169 MB / 1.768 GB, free: 12.43 MB / 1.073 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.02718/2.539, allocations: 6.48 MB / 1.774 GB, free: 5.938 MB / 1.073 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0009155/2.54, allocations: 83.92 kB / 1.774 GB, free: 5.855 MB / 1.073 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02289/2.563, allocations: 13.61 MB / 1.787 GB, free: 8.07 MB / 1.089 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.336e-05/2.563, allocations: 15.88 kB / 1.787 GB, free: 8.055 MB / 1.089 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02156/2.584, allocations: 8.517 MB / 1.796 GB, free: 15.27 MB / 1.104 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00265/2.587, allocations: 0.725 MB / 1.796 GB, free: 14.52 MB / 1.104 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0009995/2.588, allocations: 51.98 kB / 1.797 GB, free: 14.47 MB / 1.104 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004026/2.592, allocations: 487.1 kB / 1.797 GB, free: 14 MB / 1.104 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008085/2.593, allocations: 198 kB / 1.797 GB, free: 13.8 MB / 1.104 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0005083/2.594, allocations: 131.9 kB / 1.797 GB, free: 13.68 MB / 1.104 GB
Notification: Performance of sorting global known variables: time 0.002356/2.596, allocations: 1.008 MB / 1.798 GB, free: 12.66 MB / 1.104 GB
Notification: Performance of sort global known variables: time 3.81e-07/2.596, allocations: 0 / 1.798 GB, free: 12.66 MB / 1.104 GB
Notification: Performance of remove unused functions: time 0.008977/2.605, allocations: 1.648 MB / 1.8 GB, free: 11.02 MB / 1.104 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 34
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (158):
 * Single equations (assignments): 156
 * 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: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(6,100.0%) 42}
 * Non-linear torn systems: 1 {6 42}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0009068/2.606, allocations: 206.6 kB / 1.8 GB, free: 10.8 MB / 1.104 GB
Notification: Performance of simCode: created initialization part: time 0.02664/2.633, allocations: 10.69 MB / 1.811 GB, free: 88 kB / 1.104 GB
Notification: Performance of simCode: created event and clocks part: time 1.408e-05/2.633, allocations: 0 / 1.811 GB, free: 88 kB / 1.104 GB
Notification: Performance of simCode: created simulation system equations: time 0.009865/2.642, allocations: 3.666 MB / 1.814 GB, free: 12.41 MB / 1.12 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002226/2.645, allocations: 199.9 kB / 1.814 GB, free: 12.21 MB / 1.12 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03766/2.682, allocations: 12.01 MB / 1.826 GB, free: 72 kB / 1.12 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004837/2.687, allocations: 2.864 MB / 1.829 GB, free: 13.17 MB / 1.135 GB
Notification: Performance of simCode: alias equations: time 0.005762/2.693, allocations: 1.66 MB / 1.83 GB, free: 11.51 MB / 1.135 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006355/2.694, allocations: 163.3 kB / 1.831 GB, free: 11.35 MB / 1.135 GB
Notification: Performance of SimCode: time 1.012e-06/2.694, allocations: 0 / 1.831 GB, free: 11.35 MB / 1.135 GB
Notification: Performance of Templates: time 0.7707/3.465, allocations: 57.11 MB / 1.886 GB, free: 327.7 MB / 1.151 GB
make -j1 -f Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY.makefile
(rm -f Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY.pipe ; mkfifo Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY.pipe ; head -c 1048576 < Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY.pipe >> ../files/Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY.sim & ./Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Electrical_AC_ThreePhasesUnbalanced_Validation_IEEETests_Test4NodesFeeder_BalancedStepDown_DY.csv","../files/Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.DY.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches