Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY.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: "" <> buildModelFMU(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY,fileNamePrefix="Buildings_9_Buildings_Electrical_AC_ThreePhasesUnbalanced_Validation_IEEETests_Test4NodesFeeder_UnbalancedStepUp_YY",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY,fileNamePrefix="Buildings_9_Buildings_Electrical_AC_ThreePhasesUnbalanced_Validation_IEEETests_Test4NodesFeeder_UnbalancedStepUp_YY",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.1-maint.9.1.x/package.mo): time 2.368/2.368, allocations: 390.3 MB / 405.3 MB, free: 13.49 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.001298/0.001298, allocations: 183.3 kB / 498.1 MB, free: 5.73 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.745/1.745, allocations: 223.1 MB / 0.7948 GB, free: 18.84 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.0009358/0.0009358, allocations: 96.31 kB / 0.9346 GB, free: 7.148 MB / 0.6823 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004049/0.0004047, allocations: 8.875 kB / 1.084 GB, free: 212.5 MB / 0.8073 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3354/0.3359, allocations: 142.4 MB / 1.223 GB, free: 89.43 MB / 0.8073 GB
Notification: Performance of FrontEnd - scodeFlatten: time 0.8727/1.209, allocations: 211.7 MB / 1.43 GB, free: 76.7 MB / 0.9011 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0004704/1.209, allocations: 119.6 kB / 1.43 GB, free: 76.7 MB / 0.9011 GB
Notification: Performance of FrontEnd - DAE generated: time 0.3894/1.599, allocations: 166.2 MB / 1.592 GB, free: 13.3 MB / 0.9167 GB
Notification: Performance of FrontEnd: time 3.557e-06/1.599, allocations: 0 / 1.592 GB, free: 13.3 MB / 0.9167 GB
Notification: Performance of Transformations before backend: time 0.0003458/1.599, allocations: 76 kB / 1.592 GB, free: 13.23 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: 1094
 * Number of variables: 1094
Notification: Performance of Generate backend data structure: time 0.01542/1.615, allocations: 3.339 MB / 1.595 GB, free: 10.05 MB / 0.9167 GB
Notification: Performance of prepare preOptimizeDAE: time 6.103e-05/1.615, allocations: 12.03 kB / 1.596 GB, free: 10.04 MB / 0.9167 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.003885/1.618, allocations: 0.5924 MB / 1.596 GB, free: 9.691 MB / 0.9167 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01424/1.633, allocations: 2.161 MB / 1.598 GB, free: 7.527 MB / 0.9167 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.008901/1.642, allocations: 2.34 MB / 1.6 GB, free: 5.535 MB / 0.9167 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005626/1.642, allocations: 295.9 kB / 1.601 GB, free: 5.246 MB / 0.9167 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003675/1.646, allocations: 387.9 kB / 1.601 GB, free: 4.867 MB / 0.9167 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02694/1.673, allocations: 7.004 MB / 1.608 GB, free: 13.75 MB / 0.9323 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002292/1.673, allocations: 3.938 kB / 1.608 GB, free: 13.74 MB / 0.9323 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002367/1.676, allocations: 168 kB / 1.608 GB, free: 13.58 MB / 0.9323 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0006764/1.676, allocations: 318.7 kB / 1.608 GB, free: 13.27 MB / 0.9323 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02172/1.698, allocations: 6.652 MB / 1.615 GB, free: 6.605 MB / 0.9323 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.05613/1.754, allocations: 28.69 MB / 1.643 GB, free: 7.535 MB / 0.9636 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.008537/1.763, allocations: 3.72 MB / 1.647 GB, free: 3.656 MB / 0.9636 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003319/1.763, allocations: 126.3 kB / 1.647 GB, free: 3.516 MB / 0.9636 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.112e-05/1.763, allocations: 63.83 kB / 1.647 GB, free: 3.445 MB / 0.9636 GB
Notification: Performance of pre-optimization done (n=176): time 4.688e-06/1.763, allocations: 0 / 1.647 GB, free: 3.445 MB / 0.9636 GB
Notification: Performance of matching and sorting (n=221): time 0.08654/1.85, allocations: 24.23 MB / 1.67 GB, free: 11.1 MB / 0.9948 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001309/1.85, allocations: 235.6 kB / 1.671 GB, free: 10.82 MB / 0.9948 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002584/1.853, allocations: 1.484 MB / 1.672 GB, free: 9.328 MB / 0.9948 GB
Notification: Performance of collectPreVariables (initialization): time 0.0005965/1.853, allocations: 61.7 kB / 1.672 GB, free: 9.262 MB / 0.9948 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001276/1.855, allocations: 1.736 MB / 1.674 GB, free: 7.5 MB / 0.9948 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001017/1.856, allocations: 0.7665 MB / 1.675 GB, free: 6.723 MB / 0.9948 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002264/1.856, allocations: 64 kB / 1.675 GB, free: 6.66 MB / 0.9948 GB
Notification: Performance of setup shared object (initialization): time 0.0002505/1.856, allocations: 436.5 kB / 1.675 GB, free: 6.227 MB / 0.9948 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005409/1.861, allocations: 2.414 MB / 1.677 GB, free: 3.809 MB / 0.9948 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006184/1.868, allocations: 3.525 MB / 1.681 GB, free: 15.77 MB / 1.01 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006009/1.874, allocations: 2.902 MB / 1.684 GB, free: 12.88 MB / 1.01 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.175e-05/1.874, allocations: 12 kB / 1.684 GB, free: 12.86 MB / 1.01 GB
Notification: Performance of matching and sorting (n=400) (initialization): time 0.02121/1.895, allocations: 8.556 MB / 1.692 GB, free: 4.285 MB / 1.01 GB
Notification: Performance of prepare postOptimizeDAE: time 0.005323/1.9, allocations: 14.1 MB / 1.706 GB, free: 5.078 MB / 1.026 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001048/1.9, allocations: 39.98 kB / 1.706 GB, free: 5.039 MB / 1.026 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02697/1.927, allocations: 6.426 MB / 1.712 GB, free: 14.6 MB / 1.042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004324/1.932, allocations: 0.9241 MB / 1.713 GB, free: 13.67 MB / 1.042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01923/1.951, allocations: 11.94 MB / 1.725 GB, free: 1.562 MB / 1.042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004634/1.956, allocations: 0.5493 MB / 1.725 GB, free: 1.012 MB / 1.042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008517/1.957, allocations: 207.8 kB / 1.725 GB, free: 0.8086 MB / 1.042 GB
Notification: Performance of prepare postOptimizeDAE: time 1.321e-05/1.957, allocations: 4 kB / 1.725 GB, free: 0.8047 MB / 1.042 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.02058/1.977, allocations: 7.896 MB / 1.733 GB, free: 8.895 MB / 1.057 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001264/1.977, allocations: 40.62 kB / 1.733 GB, free: 8.855 MB / 1.057 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01241/1.99, allocations: 3.09 MB / 1.736 GB, free: 5.758 MB / 1.057 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005047/1.995, allocations: 1.068 MB / 1.737 GB, free: 4.688 MB / 1.057 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0158/2.011, allocations: 9.808 MB / 1.747 GB, free: 10.74 MB / 1.073 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004168/2.015, allocations: 0.5145 MB / 1.747 GB, free: 10.22 MB / 1.073 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007163/2.016, allocations: 203.9 kB / 1.748 GB, free: 10.02 MB / 1.073 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 162
 * 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 (330):
 * Single equations (assignments): 328
 * 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%) 30}
 * Non-linear torn systems: 1 {6 30}
Notification: Performance of prepare postOptimizeDAE: time 0.003833/2.02, allocations: 1.694 MB / 1.749 GB, free: 8.316 MB / 1.073 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007074/2.02, allocations: 201.7 kB / 1.749 GB, free: 8.117 MB / 1.073 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02064/2.041, allocations: 7.436 MB / 1.757 GB, free: 0.6523 MB / 1.073 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.792e-05/2.041, allocations: 24 kB / 1.757 GB, free: 0.6289 MB / 1.073 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.109e-05/2.041, allocations: 11.98 kB / 1.757 GB, free: 0.6172 MB / 1.073 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.199e-05/2.041, allocations: 11.97 kB / 1.757 GB, free: 0.6055 MB / 1.073 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.03193/2.073, allocations: 12.82 MB / 1.769 GB, free: 3.609 MB / 1.089 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.564e-05/2.073, allocations: 8 kB / 1.769 GB, free: 3.602 MB / 1.089 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003043/2.076, allocations: 0.6122 MB / 1.77 GB, free: 2.988 MB / 1.089 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.02598/2.102, allocations: 6.247 MB / 1.776 GB, free: 12.73 MB / 1.104 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0006368/2.103, allocations: 83.92 kB / 1.776 GB, free: 12.64 MB / 1.104 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01996/2.123, allocations: 11.61 MB / 1.787 GB, free: 0.8672 MB / 1.104 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.074e-05/2.123, allocations: 15.94 kB / 1.787 GB, free: 0.8516 MB / 1.104 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01905/2.142, allocations: 7.996 MB / 1.795 GB, free: 8.492 MB / 1.12 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00246/2.144, allocations: 0.6858 MB / 1.796 GB, free: 7.785 MB / 1.12 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000901/2.145, allocations: 51.95 kB / 1.796 GB, free: 7.734 MB / 1.12 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003719/2.149, allocations: 475.1 kB / 1.796 GB, free: 7.27 MB / 1.12 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006093/2.15, allocations: 173.6 kB / 1.797 GB, free: 7.098 MB / 1.12 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003714/2.15, allocations: 123.9 kB / 1.797 GB, free: 6.977 MB / 1.12 GB
Notification: Performance of sorting global known variables: time 0.002249/2.152, allocations: 1.114 MB / 1.798 GB, free: 5.863 MB / 1.12 GB
Notification: Performance of sort global known variables: time 2.21e-07/2.152, allocations: 0 / 1.798 GB, free: 5.863 MB / 1.12 GB
Notification: Performance of remove unused functions: time 0.00766/2.16, allocations: 1.66 MB / 1.799 GB, free: 4.203 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 (154):
 * Single equations (assignments): 152
 * 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%) 30}
 * Non-linear torn systems: 1 {6 30}
Notification: Performance of Backend phase and start with SimCode phase: time 0.02263/2.183, allocations: 11.57 MB / 1.811 GB, free: 8.375 MB / 1.135 GB
Notification: Performance of simCode: created initialization part: time 0.0255/2.208, allocations: 10.17 MB / 1.821 GB, free: 14.18 MB / 1.151 GB
Notification: Performance of simCode: created event and clocks part: time 1.346e-05/2.208, allocations: 0 / 1.821 GB, free: 14.18 MB / 1.151 GB
Notification: Performance of simCode: created simulation system equations: time 0.008794/2.217, allocations: 3.383 MB / 1.824 GB, free: 10.79 MB / 1.151 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001854/2.219, allocations: 215.3 kB / 1.824 GB, free: 10.58 MB / 1.151 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.5988/2.818, allocations: 52.48 MB / 1.875 GB, free: 289.1 MB / 1.151 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003565/2.821, allocations: 2.958 MB / 1.878 GB, free: 288.3 MB / 1.151 GB
Notification: Performance of simCode: alias equations: time 0.005195/2.827, allocations: 1.685 MB / 1.88 GB, free: 288.3 MB / 1.151 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001865/2.829, allocations: 1.294 MB / 1.881 GB, free: 288.3 MB / 1.151 GB
Notification: Performance of SimCode: time 8.516e-06/2.829, allocations: 1.031 kB / 1.881 GB, free: 288.3 MB / 1.151 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.108/2.937, allocations: 78.77 MB / 1.958 GB, free: 285.3 MB / 1.151 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0001569/2.937, allocations: 273.3 kB / 1.958 GB, free: 284.9 MB / 1.151 GB
Notification: Performance of buildModelFMU: Generate platform static: time 3.53/6.467, allocations: 0 / 1.958 GB, free: 284.9 MB / 1.151 GB
(rm -f Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY.pipe ; mkfifo Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY.pipe ; head -c 1048576 < Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY.pipe >> ../files/Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator -r=Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY_res.mat --tempDir=temp_Buildings_9_Buildings_Electrical_AC_ThreePhasesUnbalanced_Validation_IEEETests_Test4NodesFeeder_UnbalancedStepUp_YY_fmu --startTime=0 --stopTime=1 --timeout=50 --tolerance=1e-06 Buildings_9_Buildings_Electrical_AC_ThreePhasesUnbalanced_Validation_IEEETests_Test4NodesFeeder_UnbalancedStepUp_YY.fmu > Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY.pipe 2>&1)
TODO: How the !@#!# did the simulation report success but simulation result Buildings_9_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY_res.mat does not exist to compare? outputFormat=mat