Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.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.BalancedStepUp.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.BalancedStepUp.DY")
translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.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.BalancedStepUp.DY")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.1-maint.9.1.x/package.mo): time 2.612/2.612, allocations: 390.3 MB / 405.3 MB, free: 13.43 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.001218/0.001218, allocations: 187.3 kB / 498.1 MB, free: 5.688 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.597/1.597, allocations: 223.2 MB / 0.7948 GB, free: 18.87 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.001192/0.001192, allocations: 100.2 kB / 0.9346 GB, free: 7.156 MB / 0.6823 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004604/0.0004611, allocations: 9.5 kB / 1.084 GB, free: 212.7 MB / 0.8073 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3968/0.3973, allocations: 142.3 MB / 1.223 GB, free: 89.56 MB / 0.8073 GB
Notification: Performance of FrontEnd - scodeFlatten: time 1.175/1.572, allocations: 211.3 MB / 1.429 GB, free: 76.48 MB / 0.9011 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0004263/1.573, allocations: 117.4 kB / 1.429 GB, free: 76.48 MB / 0.9011 GB
Notification: Performance of FrontEnd - DAE generated: time 0.3437/1.916, allocations: 158.8 MB / 1.584 GB, free: 3.719 MB / 0.9011 GB
Notification: Performance of FrontEnd: time 2.766e-06/1.916, allocations: 0 / 1.584 GB, free: 3.719 MB / 0.9011 GB
Notification: Performance of Transformations before backend: time 0.0001783/1.917, allocations: 75.94 kB / 1.584 GB, free: 3.645 MB / 0.9011 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.01607/1.933, allocations: 3.184 MB / 1.588 GB, free: 0.6133 MB / 0.9011 GB
Notification: Performance of prepare preOptimizeDAE: time 6.188e-05/1.933, allocations: 8.031 kB / 1.588 GB, free: 0.6055 MB / 0.9011 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0147/1.948, allocations: 2.144 MB / 1.59 GB, free: 14.46 MB / 0.9167 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00743/1.955, allocations: 2.245 MB / 1.592 GB, free: 12.75 MB / 0.9167 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003845/1.955, allocations: 276.9 kB / 1.592 GB, free: 12.59 MB / 0.9167 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002384/1.958, allocations: 364.4 kB / 1.592 GB, free: 12.34 MB / 0.9167 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01995/1.978, allocations: 6.687 MB / 1.599 GB, free: 7 MB / 0.9167 GB
Notification: Performance of preOpt findStateOrder (simulation): time 7.858e-05/1.978, allocations: 7.922 kB / 1.599 GB, free: 6.992 MB / 0.9167 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004854/1.978, allocations: 152 kB / 1.599 GB, free: 6.844 MB / 0.9167 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.00055/1.979, allocations: 310.2 kB / 1.599 GB, free: 6.539 MB / 0.9167 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01744/1.996, allocations: 6.518 MB / 1.606 GB, free: 8 kB / 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.05314/2.05, allocations: 28.23 MB / 1.633 GB, free: 1.375 MB / 0.948 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.009694/2.059, allocations: 4.244 MB / 1.638 GB, free: 12.92 MB / 0.9636 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004202/2.06, allocations: 135.1 kB / 1.638 GB, free: 12.77 MB / 0.9636 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.529e-05/2.06, allocations: 64.45 kB / 1.638 GB, free: 12.7 MB / 0.9636 GB
Notification: Performance of pre-optimization done (n=198): time 4.708e-06/2.06, allocations: 4 kB / 1.638 GB, free: 12.7 MB / 0.9636 GB
Notification: Performance of matching and sorting (n=255): time 0.1081/2.168, allocations: 28.4 MB / 1.665 GB, free: 248 kB / 0.9792 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001646/2.168, allocations: 239.7 kB / 1.666 GB, free: 15.96 MB / 0.9948 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002359/2.171, allocations: 1.288 MB / 1.667 GB, free: 14.66 MB / 0.9948 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007766/2.171, allocations: 77.58 kB / 1.667 GB, free: 14.58 MB / 0.9948 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001301/2.173, allocations: 1.543 MB / 1.669 GB, free: 13.02 MB / 0.9948 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001432/2.174, allocations: 0.8742 MB / 1.669 GB, free: 12.13 MB / 0.9948 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002396/2.174, allocations: 60 kB / 1.669 GB, free: 12.07 MB / 0.9948 GB
Notification: Performance of setup shared object (initialization): time 0.0002979/2.175, allocations: 436.4 kB / 1.67 GB, free: 11.64 MB / 0.9948 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005751/2.18, allocations: 2.535 MB / 1.672 GB, free: 9.098 MB / 0.9948 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006745/2.187, allocations: 3.431 MB / 1.676 GB, free: 5.273 MB / 0.9948 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006738/2.194, allocations: 2.973 MB / 1.679 GB, free: 2.277 MB / 0.9948 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.697e-05/2.194, allocations: 8 kB / 1.679 GB, free: 2.27 MB / 0.9948 GB
Notification: Performance of matching and sorting (n=396) (initialization): time 0.02262/2.217, allocations: 8.832 MB / 1.687 GB, free: 9.367 MB / 1.01 GB
Notification: Performance of prepare postOptimizeDAE: time 0.005193/2.222, allocations: 10.8 MB / 1.698 GB, free: 13.71 MB / 1.026 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.852e-05/2.222, allocations: 24 kB / 1.698 GB, free: 13.69 MB / 1.026 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02823/2.25, allocations: 6.663 MB / 1.704 GB, free: 7.008 MB / 1.026 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004598/2.255, allocations: 0.8774 MB / 1.705 GB, free: 6.129 MB / 1.026 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02612/2.281, allocations: 14.02 MB / 1.719 GB, free: 7.949 MB / 1.042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004907/2.286, allocations: 0.5223 MB / 1.719 GB, free: 7.426 MB / 1.042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008802/2.287, allocations: 191.9 kB / 1.72 GB, free: 7.238 MB / 1.042 GB
Notification: Performance of prepare postOptimizeDAE: time 1.828e-05/2.287, allocations: 4 kB / 1.72 GB, free: 7.234 MB / 1.042 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.02128/2.308, allocations: 8.128 MB / 1.727 GB, free: 15.05 MB / 1.057 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001285/2.308, allocations: 24 kB / 1.727 GB, free: 15.03 MB / 1.057 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01281/2.321, allocations: 3.209 MB / 1.731 GB, free: 11.81 MB / 1.057 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005493/2.327, allocations: 1.045 MB / 1.732 GB, free: 10.77 MB / 1.057 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01883/2.346, allocations: 11.53 MB / 1.743 GB, free: 15.1 MB / 1.073 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004501/2.35, allocations: 0.4951 MB / 1.743 GB, free: 14.61 MB / 1.073 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007127/2.351, allocations: 191.9 kB / 1.744 GB, free: 14.42 MB / 1.073 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.004029/2.355, allocations: 1.616 MB / 1.745 GB, free: 12.79 MB / 1.073 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00077/2.356, allocations: 193.7 kB / 1.745 GB, free: 12.6 MB / 1.073 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02104/2.377, allocations: 8.572 MB / 1.754 GB, free: 3.973 MB / 1.073 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.841e-05/2.377, allocations: 28 kB / 1.754 GB, free: 3.945 MB / 1.073 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.543e-05/2.377, allocations: 12 kB / 1.754 GB, free: 3.934 MB / 1.073 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.274e-05/2.377, allocations: 11.95 kB / 1.754 GB, free: 3.922 MB / 1.073 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.03408/2.411, allocations: 13.67 MB / 1.767 GB, free: 6.074 MB / 1.089 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.951e-05/2.411, allocations: 8.969 kB / 1.767 GB, free: 6.066 MB / 1.089 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003342/2.415, allocations: 0.6161 MB / 1.768 GB, free: 5.449 MB / 1.089 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.02684/2.441, allocations: 6.48 MB / 1.774 GB, free: 14.96 MB / 1.104 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0009386/2.442, allocations: 79.92 kB / 1.774 GB, free: 14.88 MB / 1.104 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02222/2.465, allocations: 13.63 MB / 1.787 GB, free: 1.082 MB / 1.104 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 9.878e-06/2.465, allocations: 11.94 kB / 1.787 GB, free: 1.07 MB / 1.104 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02042/2.485, allocations: 8.513 MB / 1.796 GB, free: 8.289 MB / 1.12 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002873/2.488, allocations: 0.7329 MB / 1.796 GB, free: 7.535 MB / 1.12 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006493/2.489, allocations: 55.98 kB / 1.797 GB, free: 7.48 MB / 1.12 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003508/2.492, allocations: 491.1 kB / 1.797 GB, free: 7 MB / 1.12 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006293/2.493, allocations: 197.9 kB / 1.797 GB, free: 6.809 MB / 1.12 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003111/2.493, allocations: 131.9 kB / 1.797 GB, free: 6.68 MB / 1.12 GB
Notification: Performance of sorting global known variables: time 0.002113/2.495, allocations: 1.012 MB / 1.798 GB, free: 5.664 MB / 1.12 GB
Notification: Performance of sort global known variables: time 6.41e-07/2.495, allocations: 0 / 1.798 GB, free: 5.664 MB / 1.12 GB
Notification: Performance of remove unused functions: time 0.008338/2.504, allocations: 1.656 MB / 1.8 GB, free: 4.008 MB / 1.12 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.0006732/2.504, allocations: 196.1 kB / 1.8 GB, free: 3.809 MB / 1.12 GB
Notification: Performance of simCode: created initialization part: time 0.0274/2.532, allocations: 10.68 MB / 1.811 GB, free: 9.09 MB / 1.135 GB
Notification: Performance of simCode: created event and clocks part: time 1.658e-05/2.532, allocations: 7.938 kB / 1.811 GB, free: 9.082 MB / 1.135 GB
Notification: Performance of simCode: created simulation system equations: time 0.009966/2.542, allocations: 3.665 MB / 1.814 GB, free: 5.402 MB / 1.135 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002359/2.544, allocations: 200.8 kB / 1.814 GB, free: 5.207 MB / 1.135 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0345/2.579, allocations: 12.01 MB / 1.826 GB, free: 9.066 MB / 1.151 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003506/2.582, allocations: 2.868 MB / 1.829 GB, free: 6.164 MB / 1.151 GB
Notification: Performance of simCode: alias equations: time 0.005405/2.588, allocations: 1.667 MB / 1.83 GB, free: 4.492 MB / 1.151 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006653/2.588, allocations: 159.3 kB / 1.831 GB, free: 4.336 MB / 1.151 GB
Notification: Performance of SimCode: time 1.142e-06/2.588, allocations: 0 / 1.831 GB, free: 4.336 MB / 1.151 GB
Notification: Performance of Templates: time 0.752/3.34, allocations: 57.03 MB / 1.886 GB, free: 317.6 MB / 1.151 GB
make -j1 -f Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.DY.makefile
(rm -f Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.DY.pipe ; mkfifo Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.DY.pipe ; head -c 1048576 < Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.DY.pipe >> ../files/Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.DY.sim & ./Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.DY  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.DY.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.DY_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Electrical_AC_ThreePhasesUnbalanced_Validation_IEEETests_Test4NodesFeeder_BalancedStepUp_DY.csv","../files/Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.DY.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches