Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.0008362/0.0008362, allocations: 80.48 kB / 19.93 MB, free: 4.629 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.0008169/0.0008169, allocations: 177.9 kB / 23.21 MB, free: 1.348 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.8927/0.8927, allocations: 177.1 MB / 203.5 MB, free: 5.727 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.2-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.2-maint.12.x/package.mo): time 1.709/1.709, allocations: 377.8 MB / 0.6228 GB, free: 8.652 MB / 0.5886 GB
"
[Timeout remaining time 178]
Using package Buildings with version 12.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.2-maint.12.x/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,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_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD")
translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,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_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.362e-06/1.362e-06, allocations: 0 / 0.9823 GB, free: 1.953 MB / 0.9323 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.122e-05/2.258e-05, allocations: 2.281 kB / 0.9823 GB, free: 1.949 MB / 0.9323 GB
Notification: Performance of NFInst.instantiate(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD): time 0.01303/0.01305, allocations: 17.53 MB / 0.9994 GB, free: 364 kB / 0.948 GB
Notification: Performance of NFInst.instExpressions: time 0.007722/0.02077, allocations: 6.663 MB / 1.006 GB, free: 9.676 MB / 0.9636 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0009393/0.02171, allocations: 63.75 kB / 1.006 GB, free: 9.613 MB / 0.9636 GB
Notification: Performance of NFTyping.typeComponents: time 0.001946/0.02366, allocations: 1.499 MB / 1.007 GB, free: 8.109 MB / 0.9636 GB
Notification: Performance of NFTyping.typeBindings: time 0.002095/0.02575, allocations: 1.484 MB / 1.009 GB, free: 6.617 MB / 0.9636 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002193/0.02794, allocations: 1.289 MB / 1.01 GB, free: 5.328 MB / 0.9636 GB
Notification: Performance of NFFlatten.flatten: time 0.003752/0.0317, allocations: 5.553 MB / 1.016 GB, free: 15.76 MB / 0.9792 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003094/0.03479, allocations: 3.367 MB / 1.019 GB, free: 12.3 MB / 0.9792 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003033/0.03782, allocations: 3.329 MB / 1.022 GB, free: 8.965 MB / 0.9792 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002604/0.04043, allocations: 2.884 MB / 1.025 GB, free: 6.074 MB / 0.9792 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004544/0.04088, allocations: 0.5234 MB / 1.025 GB, free: 5.551 MB / 0.9792 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001509/0.04239, allocations: 1.217 MB / 1.027 GB, free: 4.332 MB / 0.9792 GB
Notification: Performance of NFScalarize.scalarize: time 0.001444/0.04383, allocations: 2.405 MB / 1.029 GB, free: 1.922 MB / 0.9792 GB
Notification: Performance of NFVerifyModel.verify: time 0.001202/0.04504, allocations: 1.552 MB / 1.031 GB, free: 376 kB / 0.9792 GB
Notification: Performance of NFConvertDAE.convert: time 0.005419/0.05045, allocations: 7.987 MB / 1.038 GB, free: 8.359 MB / 0.9948 GB
Notification: Performance of FrontEnd - DAE generated: time 2.094e-06/0.05046, allocations: 0 / 1.038 GB, free: 8.359 MB / 0.9948 GB
Notification: Performance of FrontEnd: time 1.182e-06/0.05046, allocations: 7.875 kB / 1.038 GB, free: 8.352 MB / 0.9948 GB
Notification: Performance of Transformations before backend: time 9.299e-05/0.05055, allocations: 0 / 1.038 GB, free: 8.352 MB / 0.9948 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 994
 * Number of variables: 994
Notification: Performance of Generate backend data structure: time 0.004578/0.05513, allocations: 3.797 MB / 1.042 GB, free: 4.508 MB / 0.9948 GB
Notification: Performance of prepare preOptimizeDAE: time 3.748e-05/0.05517, allocations: 16.03 kB / 1.042 GB, free: 4.492 MB / 0.9948 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006306/0.06147, allocations: 2.44 MB / 1.044 GB, free: 2.047 MB / 0.9948 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.452/0.5135, allocations: 2.168 MB / 1.047 GB, free: 97.18 MB / 0.9948 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001992/0.5137, allocations: 271.9 kB / 1.047 GB, free: 97.17 MB / 0.9948 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001197/0.5149, allocations: 350.4 kB / 1.047 GB, free: 97.17 MB / 0.9948 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.008355/0.5233, allocations: 7.23 MB / 1.054 GB, free: 94.75 MB / 0.9948 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.351e-05/0.5233, allocations: 5.406 kB / 1.054 GB, free: 94.75 MB / 0.9948 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002655/0.5236, allocations: 150.7 kB / 1.054 GB, free: 94.64 MB / 0.9948 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002423/0.5238, allocations: 332.2 kB / 1.055 GB, free: 94.61 MB / 0.9948 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007552/0.5314, allocations: 7.037 MB / 1.062 GB, free: 92.61 MB / 0.9948 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.01466/0.546, allocations: 17.9 MB / 1.079 GB, free: 82.5 MB / 0.9948 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004283/0.5503, allocations: 3.727 MB / 1.083 GB, free: 81.23 MB / 0.9948 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003474/0.5538, allocations: 2.525 MB / 1.085 GB, free: 80.49 MB / 0.9948 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001438/0.5539, allocations: 46.92 kB / 1.085 GB, free: 80.48 MB / 0.9948 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.067e-05/0.554, allocations: 64.89 kB / 1.085 GB, free: 80.43 MB / 0.9948 GB
Notification: Performance of pre-optimization done (n=208): time 3.537e-06/0.554, allocations: 0 / 1.085 GB, free: 80.43 MB / 0.9948 GB
Warning: The linear system: 
1 : line2.v1_n[1] - line2.v1_p[1] = line2.Z11[1] * line2.i1[1] - line2.Z11[2] * line2.i1[2] + line2.Z12[1] * line2.i2[1] - line2.Z12[2] * line2.i2[2] + line2.Z13[1] * line2.i3[1] - line2.Z13[2] * line2.i3[2]
2 : loadRL.load1.v[1] = line2.v1_p[1] - line2.v2_p[1]
3 : line2.v2_n[1] - line2.v2_p[1] = line2.Z21[1] * line2.i1[1] - line2.Z21[2] * line2.i1[2] + line2.Z22[1] * line2.i2[1] - line2.Z22[2] * line2.i2[2] + line2.Z23[1] * line2.i3[1] - line2.Z23[2] * line2.i3[2]
4 : transformer.conv1.V2[1] = line2.v1_n[1] - line2.v2_n[1]
[
  1.0 , 0.0 , 0.0 , -1.0 ;
  0.0 , 0.0 , 1.0 , -1.0 ;
  0.0 , 1.0 , -1.0 , 0.0 ;
  -1.0 , 1.0 , 0.0 , 0.0
]
  *
[
  line2.v1_n[1] ;
  line2.v2_n[1] ;
  line2.v2_p[1] ;
  line2.v1_p[1]
]
  =
[
  line2.Z11[1] * line2.i1[1] + line2.Z13[1] * line2.i3[1] + line2.Z12[1] * line2.i2[1] - line2.Z11[2] * line2.i1[2] - line2.Z13[2] * line2.i3[2] - line2.Z12[2] * line2.i2[2] ;
  -loadRL.load1.v[1] ;
  line2.Z21[1] * line2.i1[1] + line2.Z23[1] * line2.i3[1] + line2.Z22[1] * line2.i2[1] - line2.Z21[2] * line2.i1[2] - line2.Z23[2] * line2.i3[2] - line2.Z22[2] * line2.i2[2] ;
  -transformer.conv1.V2[1]
]
 might be structurally or numerically singular for variable line2.v1_p[1] since U(4,4) = 0.0. It might be hard to solve. Compilation continues anyway.
Notification: Performance of matching and sorting (n=271): time 0.06116/0.6151, allocations: 30.78 MB / 1.115 GB, free: 73.52 MB / 0.9948 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.573e-05/0.6152, allocations: 247 kB / 1.116 GB, free: 73.25 MB / 0.9948 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002177/0.6174, allocations: 1.439 MB / 1.117 GB, free: 72.73 MB / 0.9948 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003352/0.6177, allocations: 67.8 kB / 1.117 GB, free: 72.66 MB / 0.9948 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007637/0.6185, allocations: 1.554 MB / 1.119 GB, free: 71.51 MB / 0.9948 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0008114/0.6193, allocations: 0.9508 MB / 1.119 GB, free: 70.76 MB / 0.9948 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001049/0.6203, allocations: 0.632 MB / 1.12 GB, free: 70.45 MB / 0.9948 GB
Notification: Performance of setup shared object (initialization): time 3.219e-05/0.6204, allocations: 306.1 kB / 1.12 GB, free: 70.14 MB / 0.9948 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00478/0.6252, allocations: 2.688 MB / 1.123 GB, free: 68.75 MB / 0.9948 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004119/0.6293, allocations: 3.65 MB / 1.127 GB, free: 66.14 MB / 0.9948 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00727/0.6366, allocations: 6.402 MB / 1.133 GB, free: 62.12 MB / 0.9948 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.835e-05/0.6366, allocations: 8 kB / 1.133 GB, free: 62.12 MB / 0.9948 GB
Warning: The linear system: 
1 : line2.v1_n[1] - line2.v1_p[1] = line2.Z11[1] * line2.i1[1] - line2.Z11[2] * line2.i1[2] + line2.Z12[1] * line2.i2[1] - line2.Z12[2] * line2.i2[2] + line2.Z13[1] * line2.i3[1] - line2.Z13[2] * line2.i3[2]
2 : loadRL.load1.v[1] = line2.v1_p[1] - line2.v2_p[1]
3 : line2.v2_n[1] - line2.v2_p[1] = line2.Z21[1] * line2.i1[1] - line2.Z21[2] * line2.i1[2] + line2.Z22[1] * line2.i2[1] - line2.Z22[2] * line2.i2[2] + line2.Z23[1] * line2.i3[1] - line2.Z23[2] * line2.i3[2]
4 : transformer.conv1.V2[1] = line2.v1_n[1] - line2.v2_n[1]
[
  1.0 , 0.0 , 0.0 , -1.0 ;
  0.0 , 0.0 , 1.0 , -1.0 ;
  0.0 , 1.0 , -1.0 , 0.0 ;
  -1.0 , 1.0 , 0.0 , 0.0
]
  *
[
  line2.v1_n[1] ;
  line2.v2_n[1] ;
  line2.v2_p[1] ;
  line2.v1_p[1]
]
  =
[
  line2.Z11[1] * line2.i1[1] + line2.Z13[1] * line2.i3[1] + line2.Z12[1] * line2.i2[1] - line2.Z11[2] * line2.i1[2] - line2.Z13[2] * line2.i3[2] - line2.Z12[2] * line2.i2[2] ;
  -loadRL.load1.v[1] ;
  line2.Z21[1] * line2.i1[1] + line2.Z23[1] * line2.i3[1] + line2.Z22[1] * line2.i2[1] - line2.Z21[2] * line2.i1[2] - line2.Z23[2] * line2.i3[2] - line2.Z22[2] * line2.i2[2] ;
  -transformer.conv1.V2[1]
]
 might be structurally or numerically singular for variable line2.v1_p[1] since U(4,4) = 0.0. It might be hard to solve. Compilation continues anyway.
Notification: Performance of matching and sorting (n=410) (initialization): time 0.01462/0.6512, allocations: 10.79 MB / 1.143 GB, free: 54.86 MB / 0.9948 GB
Notification: Performance of prepare postOptimizeDAE: time 3.155e-05/0.6512, allocations: 19.94 kB / 1.143 GB, free: 54.84 MB / 0.9948 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.226e-05/0.6512, allocations: 31.94 kB / 1.143 GB, free: 54.81 MB / 0.9948 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00925/0.6605, allocations: 5.528 MB / 1.149 GB, free: 49.27 MB / 0.9948 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002084/0.6626, allocations: 0.9906 MB / 1.15 GB, free: 48.28 MB / 0.9948 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02162/0.6842, allocations: 27.39 MB / 1.176 GB, free: 20.59 MB / 0.9948 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002799/0.687, allocations: 0.5771 MB / 1.177 GB, free: 20.01 MB / 0.9948 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001934/0.6872, allocations: 151.9 kB / 1.177 GB, free: 19.86 MB / 0.9948 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.004691/0.6919, allocations: 3.984 MB / 1.181 GB, free: 15.87 MB / 0.9948 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003129/0.695, allocations: 3.604 MB / 1.185 GB, free: 11.87 MB / 0.9948 GB
Error: Initialization problem is structural singular. Please, check the initial conditions.
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.04301/0.738, allocations: 24.46 MB / 1.208 GB, free: 2.938 MB / 1.01 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.816e-05/0.7381, allocations: 15.98 kB / 1.209 GB, free: 2.922 MB / 1.01 GB
Warning: The linear system: 
1 : transformer.conv3.V2[2] = line2.v3_n[2] - line2.v1_n[2]
2 : line2.v3_n[2] - line2.v3_p[2] = line2.Z31[1] * line2.i1[2] + line2.Z31[2] * line2.i1[1] + line2.Z32[1] * line2.i2[2] + line2.Z32[2] * line2.i2[1] + line2.Z33[1] * line2.i3[2] + line2.Z33[2] * line2.i3[1]
3 : loadRL.load3.v[2] = line2.v3_p[2] - line2.v1_p[2]
4 : line2.v1_n[2] - line2.v1_p[2] = line2.Z11[1] * line2.i1[2] + line2.Z11[2] * line2.i1[1] + line2.Z12[1] * line2.i2[2] + line2.Z12[2] * line2.i2[1] + line2.Z13[1] * line2.i3[2] + line2.Z13[2] * line2.i3[1]
[
  1.0 , 0.0 , 0.0 , -1.0 ;
  0.0 , 0.0 , -1.0 , 1.0 ;
  0.0 , 1.0 , -1.0 , 0.0 ;
  1.0 , -1.0 , 0.0 , 0.0
]
  *
[
  line2.v1_n[2] ;
  line2.v1_p[2] ;
  line2.v3_p[2] ;
  line2.v3_n[2]
]
  =
[
  -transformer.conv3.V2[2] ;
  line2.Z31[1] * line2.i1[2] + line2.Z33[1] * line2.i3[2] + line2.Z33[2] * line2.i3[1] + line2.Z32[2] * line2.i2[1] + line2.Z32[1] * line2.i2[2] + line2.Z31[2] * line2.i1[1] ;
  -loadRL.load3.v[2] ;
  line2.Z11[1] * line2.i1[2] + line2.Z13[1] * line2.i3[2] + line2.Z13[2] * line2.i3[1] + line2.Z12[2] * line2.i2[1] + line2.Z12[1] * line2.i2[2] + line2.Z11[2] * line2.i1[1]
]
 might be structurally or numerically singular for variable line2.v3_n[2] since U(4,4) = 0.0. It might be hard to solve. Compilation continues anyway.
Warning: The linear system: 
1 : transformer.conv1.V2[1] = line2.v1_n[1] - line2.v2_n[1]
2 : line2.v1_n[1] - line2.v1_p[1] = line2.Z11[1] * line2.i1[1] - line2.Z11[2] * line2.i1[2] + line2.Z12[1] * line2.i2[1] - line2.Z12[2] * line2.i2[2] + line2.Z13[1] * line2.i3[1] - line2.Z13[2] * line2.i3[2]
3 : loadRL.load1.v[1] = line2.v1_p[1] - line2.v2_p[1]
4 : line2.v2_n[1] - line2.v2_p[1] = line2.Z21[1] * line2.i1[1] - line2.Z21[2] * line2.i1[2] + line2.Z22[1] * line2.i2[1] - line2.Z22[2] * line2.i2[2] + line2.Z23[1] * line2.i3[1] - line2.Z23[2] * line2.i3[2]
[
  1.0 , 0.0 , 0.0 , -1.0 ;
  0.0 , 0.0 , -1.0 , 1.0 ;
  0.0 , 1.0 , -1.0 , 0.0 ;
  1.0 , -1.0 , 0.0 , 0.0
]
  *
[
  line2.v2_n[1] ;
  line2.v2_p[1] ;
  line2.v1_p[1] ;
  line2.v1_n[1]
]
  =
[
  -transformer.conv1.V2[1] ;
  line2.Z11[1] * line2.i1[1] + line2.Z13[1] * line2.i3[1] + line2.Z12[1] * line2.i2[1] - line2.Z11[2] * line2.i1[2] - line2.Z13[2] * line2.i3[2] - line2.Z12[2] * line2.i2[2] ;
  -loadRL.load1.v[1] ;
  line2.Z21[1] * line2.i1[1] + line2.Z23[1] * line2.i3[1] + line2.Z22[1] * line2.i2[1] - line2.Z21[2] * line2.i1[2] - line2.Z23[2] * line2.i3[2] - line2.Z22[2] * line2.i2[2]
]
 might be structurally or numerically singular for variable line2.v1_n[1] since U(4,4) = 0.0. It might be hard to solve. Compilation continues anyway.
Notification: Performance of matching and sorting (n=410) (initialization_lambda0): time 0.01442/0.7525, allocations: 10.17 MB / 1.218 GB, free: 8.684 MB / 1.026 GB
Notification: Performance of prepare postOptimizeDAE: time 2.669e-05/0.7525, allocations: 16 kB / 1.218 GB, free: 8.668 MB / 1.026 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.376e-05/0.7525, allocations: 28 kB / 1.218 GB, free: 8.641 MB / 1.026 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007889/0.7604, allocations: 4.308 MB / 1.223 GB, free: 4.316 MB / 1.026 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002189/0.7626, allocations: 1.041 MB / 1.224 GB, free: 3.273 MB / 1.026 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02154/0.7842, allocations: 26.14 MB / 1.249 GB, free: 8.621 MB / 1.057 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002624/0.7868, allocations: 0.5576 MB / 1.25 GB, free: 8.062 MB / 1.057 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000254/0.787, allocations: 152 kB / 1.25 GB, free: 7.914 MB / 1.057 GB
Warning: Assuming fixed start value for the following 2 variables:
         node4.wyeToDelta.delta.phase[3].v[2]:VARIABLE(flow=false unit = \"V\" fixed = true )  \"Voltage vector\" type: Real [3,2]
         node4.wyeToDelta.delta.phase[2].v[1]:VARIABLE(flow=false unit = \"V\" fixed = true )  \"Voltage vector\" type: Real [3,2]
Warning: The initial conditions are over specified. The following 2 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         0.0 = (-line2.i2[2]) - line2.i3[2] - line2.i1[2]
         0.0 = (-line2.i2[1]) - line2.i3[1] - line2.i1[1].
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 119
 * 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 (301):
 * Single equations (assignments): 298
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,3,100.0%), (10,44,70.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(10,44)}
Notification: Performance of prepare postOptimizeDAE: time 0.0007711/0.7878, allocations: 395.6 kB / 1.25 GB, free: 7.523 MB / 1.057 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003692/0.7882, allocations: 198.9 kB / 1.25 GB, free: 7.328 MB / 1.057 GB
Warning: The linear system: 
1 : line2.v1_n[1] - line2.v1_p[1] = line2.Z11[1] * line2.i1[1] - line2.Z11[2] * line2.i1[2] + line2.Z12[1] * line2.i2[1] - line2.Z12[2] * line2.i2[2] + line2.Z13[1] * line2.i3[1] - line2.Z13[2] * line2.i3[2]
2 : loadRL.load1.v[1] = line2.v1_p[1] - line2.v2_p[1]
3 : line2.v2_n[1] - line2.v2_p[1] = line2.Z21[1] * line2.i1[1] - line2.Z21[2] * line2.i1[2] + line2.Z22[1] * line2.i2[1] - line2.Z22[2] * line2.i2[2] + line2.Z23[1] * line2.i3[1] - line2.Z23[2] * line2.i3[2]
4 : transformer.conv1.V2[1] = line2.v1_n[1] - line2.v2_n[1]
[
  1.0 , 0.0 , 0.0 , -1.0 ;
  0.0 , 0.0 , 1.0 , -1.0 ;
  0.0 , 1.0 , -1.0 , 0.0 ;
  -1.0 , 1.0 , 0.0 , 0.0
]
  *
[
  line2.v1_n[1] ;
  line2.v2_n[1] ;
  line2.v2_p[1] ;
  line2.v1_p[1]
]
  =
[
  line2.Z11[1] * line2.i1[1] + line2.Z13[1] * line2.i3[1] + line2.Z12[1] * line2.i2[1] - line2.Z11[2] * line2.i1[2] - line2.Z13[2] * line2.i3[2] - line2.Z12[2] * line2.i2[2] ;
  -loadRL.load1.v[1] ;
  line2.Z21[1] * line2.i1[1] + line2.Z23[1] * line2.i3[1] + line2.Z22[1] * line2.i2[1] - line2.Z21[2] * line2.i1[2] - line2.Z23[2] * line2.i3[2] - line2.Z22[2] * line2.i2[2] ;
  -transformer.conv1.V2[1]
]
 might be structurally or numerically singular for variable line2.v1_p[1] since U(4,4) = 0.0. It might be hard to solve. Compilation continues anyway.
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01417/0.8023, allocations: 9.939 MB / 1.26 GB, free: 13.34 MB / 1.073 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.849e-05/0.8024, allocations: 32 kB / 1.26 GB, free: 13.31 MB / 1.073 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.578e-05/0.8024, allocations: 12 kB / 1.26 GB, free: 13.3 MB / 1.073 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.912e-05/0.8024, allocations: 19.94 kB / 1.26 GB, free: 13.28 MB / 1.073 GB
Warning: The linear system: 
1 : loadRL.load1.v[1] = line2.v1_p[1] - line2.v2_p[1]
2 : line2.v2_n[1] - line2.v2_p[1] = line2.Z21[1] * line2.i1[1] - line2.Z21[2] * line2.i1[2] + line2.Z22[1] * line2.i2[1] - line2.Z22[2] * line2.i2[2] + line2.Z23[1] * line2.i3[1] - line2.Z23[2] * line2.i3[2]
3 : transformer.conv1.V2[1] = line2.v1_n[1] - line2.v2_n[1]
4 : line2.v1_n[1] - line2.v1_p[1] = line2.Z11[1] * line2.i1[1] - line2.Z11[2] * line2.i1[2] + line2.Z12[1] * line2.i2[1] - line2.Z12[2] * line2.i2[2] + line2.Z13[1] * line2.i3[1] - line2.Z13[2] * line2.i3[2]
[
  -1.0 , 0.0 , 0.0 , 1.0 ;
  0.0 , 0.0 , 1.0 , -1.0 ;
  0.0 , -1.0 , 1.0 , 0.0 ;
  -1.0 , 1.0 , 0.0 , 0.0
]
  *
[
  line2.v1_p[1] ;
  line2.v1_n[1] ;
  line2.v2_n[1] ;
  line2.v2_p[1]
]
  =
[
  -loadRL.load1.v[1] ;
  line2.Z21[1] * line2.i1[1] + line2.Z23[1] * line2.i3[1] + line2.Z22[1] * line2.i2[1] - line2.Z21[2] * line2.i1[2] - line2.Z23[2] * line2.i3[2] - line2.Z22[2] * line2.i2[2] ;
  -transformer.conv1.V2[1] ;
  line2.Z11[1] * line2.i1[1] + line2.Z13[1] * line2.i3[1] + line2.Z12[1] * line2.i2[1] - line2.Z11[2] * line2.i1[2] - line2.Z13[2] * line2.i3[2] - line2.Z12[2] * line2.i2[2]
]
 might be structurally or numerically singular for variable line2.v2_p[1] since U(4,4) = 0.0. It might be hard to solve. Compilation continues anyway.
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01985/0.8222, allocations: 14.78 MB / 1.275 GB, free: 14.41 MB / 1.089 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.077e-05/0.8223, allocations: 8 kB / 1.275 GB, free: 14.4 MB / 1.089 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001563/0.8238, allocations: 0.7337 MB / 1.275 GB, free: 13.66 MB / 1.089 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.009469/0.8333, allocations: 5.168 MB / 1.28 GB, free: 8.484 MB / 1.089 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002681/0.8336, allocations: 75.95 kB / 1.281 GB, free: 8.41 MB / 1.089 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0252/0.8588, allocations: 26.45 MB / 1.306 GB, free: 13.59 MB / 1.12 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.242e-06/0.8588, allocations: 12.03 kB / 1.306 GB, free: 13.58 MB / 1.12 GB
Warning: The linear system: 
1 : transformer.conv1.V2[1] = line2.v1_n[1] - line2.v2_n[1]
2 : line2.v1_n[1] - line2.v1_p[1] = line2.Z11[1] * line2.i1[1] - line2.Z11[2] * line2.i1[2] + line2.Z12[1] * line2.i2[1] - line2.Z12[2] * line2.i2[2] + line2.Z13[1] * line2.i3[1] - line2.Z13[2] * line2.i3[2]
3 : loadRL.load1.v[1] = line2.v1_p[1] - line2.v2_p[1]
4 : line2.v2_n[1] - line2.v2_p[1] = line2.Z21[1] * line2.i1[1] - line2.Z21[2] * line2.i1[2] + line2.Z22[1] * line2.i2[1] - line2.Z22[2] * line2.i2[2] + line2.Z23[1] * line2.i3[1] - line2.Z23[2] * line2.i3[2]
[
  1.0 , 0.0 , 0.0 , -1.0 ;
  0.0 , 0.0 , -1.0 , 1.0 ;
  0.0 , 1.0 , -1.0 , 0.0 ;
  1.0 , -1.0 , 0.0 , 0.0
]
  *
[
  line2.v2_n[1] ;
  line2.v2_p[1] ;
  line2.v1_p[1] ;
  line2.v1_n[1]
]
  =
[
  -transformer.conv1.V2[1] ;
  line2.Z11[1] * line2.i1[1] + line2.Z13[1] * line2.i3[1] + line2.Z12[1] * line2.i2[1] - line2.Z11[2] * line2.i1[2] - line2.Z13[2] * line2.i3[2] - line2.Z12[2] * line2.i2[2] ;
  -loadRL.load1.v[1] ;
  line2.Z21[1] * line2.i1[1] + line2.Z23[1] * line2.i3[1] + line2.Z22[1] * line2.i2[1] - line2.Z21[2] * line2.i1[2] - line2.Z23[2] * line2.i3[2] - line2.Z22[2] * line2.i2[2]
]
 might be structurally or numerically singular for variable line2.v1_n[1] since U(4,4) = 0.0. It might be hard to solve. Compilation continues anyway.
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01422/0.873, allocations: 9.854 MB / 1.316 GB, free: 3.508 MB / 1.12 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001186/0.8742, allocations: 0.6507 MB / 1.317 GB, free: 2.855 MB / 1.12 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002431/0.8744, allocations: 52 kB / 1.317 GB, free: 2.805 MB / 1.12 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001711/0.8761, allocations: 0.5109 MB / 1.317 GB, free: 2.293 MB / 1.12 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005495/0.8767, allocations: 238.3 kB / 1.317 GB, free: 2.059 MB / 1.12 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001375/0.8768, allocations: 91.95 kB / 1.318 GB, free: 1.969 MB / 1.12 GB
Notification: Performance of sorting global known variables: time 0.0009876/0.8778, allocations: 0.944 MB / 1.318 GB, free: 1.02 MB / 1.12 GB
Notification: Performance of sort global known variables: time 6e-08/0.8778, allocations: 4 kB / 1.318 GB, free: 1.016 MB / 1.12 GB
Notification: Performance of remove unused functions: time 0.00477/0.8826, allocations: 1.852 MB / 1.32 GB, free: 15.16 MB / 1.135 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 (165):
 * Single equations (assignments): 162
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(10,44,70.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(10,44)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0003372/0.8829, allocations: 186.7 kB / 1.32 GB, free: 14.97 MB / 1.135 GB
Notification: Performance of simCode: created initialization part: time 0.01575/0.8987, allocations: 12.01 MB / 1.332 GB, free: 2.859 MB / 1.135 GB
Notification: Performance of simCode: created event and clocks part: time 7.675e-06/0.8987, allocations: 8.188 kB / 1.332 GB, free: 2.852 MB / 1.135 GB
Notification: Performance of simCode: created simulation system equations: time 0.005809/0.9045, allocations: 4.243 MB / 1.336 GB, free: 14.56 MB / 1.151 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001416/0.9059, allocations: 268.5 kB / 1.337 GB, free: 14.31 MB / 1.151 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01416/0.92, allocations: 10.23 MB / 1.347 GB, free: 3.953 MB / 1.151 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002194/0.9222, allocations: 2.355 MB / 1.349 GB, free: 1.559 MB / 1.151 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007155/0.923, allocations: 208.3 kB / 1.349 GB, free: 1.355 MB / 1.151 GB
Notification: Performance of SimCode: time 1.062e-06/0.923, allocations: 0 / 1.349 GB, free: 1.355 MB / 1.151 GB
Notification: Performance of Templates: time 0.0785/1.001, allocations: 109.2 MB / 1.456 GB, free: 4.074 MB / 1.26 GB
"
[Timeout remaining time 299]
make -j1 -f Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD.pipe ; mkfifo Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD.pipe ; head -c 1048576 < Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD.pipe >> ../files/Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD.sim & ./Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YD.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 10.995578753761947]
Failed to read output from testmodel.py, exit status != 0:
1.0076966974884272 1.015255792 0.963194128
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x70a902dc0440>