Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.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.0008442/0.0008442, allocations: 68.47 kB / 19.17 MB, free: 0.7344 MB / 13.93 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.0008229/0.0008229, allocations: 173.9 kB / 22.46 MB, free: 2.09 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.8837/0.8837, allocations: 177.1 MB / 202.8 MB, free: 5.723 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Examples/PPD12/Structure.mo:531:21-531:190:writable] Warning: Lexer treating \\ as \\\\, since \\e is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Examples/PPD12/Structure.mo:531:21-531:198:writable] Warning: Lexer treating \\ as \\\\, since \\< is not a valid Modelica escape sequence.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/package.mo): time 0.713/0.713, allocations: 154.6 MB / 413.7 MB, free: 0.8086 MB / 378.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Utilities/Cryptographics/BaseClasses/sha.mo:2:1-19:8:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Utilities/File/sha2.mo:2:1-9:9:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 179]
Using package IDEAS with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/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: "" <> buildModelFMU(IDEAS.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YD,fileNamePrefix="IDEAS_dev_IDEAS_Electrical_AC_ThreePhasesUnbalanced_Validation_IEEETests_Test4NodesFeeder_BalancedStepDown_YD",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(IDEAS.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YD,fileNamePrefix="IDEAS_dev_IDEAS_Electrical_AC_ThreePhasesUnbalanced_Validation_IEEETests_Test4NodesFeeder_BalancedStepDown_YD",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 2.074e-06/2.074e-06, allocations: 0 / 0.6181 GB, free: 13.61 MB / 0.5886 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.409e-05/1.616e-05, allocations: 8 kB / 0.6181 GB, free: 13.61 MB / 0.5886 GB
Notification: Performance of NFInst.instantiate(IDEAS.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YD): time 0.01406/0.01408, allocations: 17.43 MB / 0.6352 GB, free: 12.11 MB / 0.6042 GB
Notification: Performance of NFInst.instExpressions: time 0.008291/0.02237, allocations: 6.648 MB / 0.6417 GB, free: 5.445 MB / 0.6042 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001037/0.0234, allocations: 67.69 kB / 0.6417 GB, free: 5.379 MB / 0.6042 GB
Notification: Performance of NFTyping.typeComponents: time 0.0021/0.0255, allocations: 1.488 MB / 0.6432 GB, free: 3.883 MB / 0.6042 GB
Notification: Performance of NFTyping.typeBindings: time 0.002395/0.0279, allocations: 1.469 MB / 0.6446 GB, free: 2.406 MB / 0.6042 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00218/0.03008, allocations: 1.27 MB / 0.6459 GB, free: 1.137 MB / 0.6042 GB
Notification: Performance of NFFlatten.flatten: time 0.004187/0.03427, allocations: 5.522 MB / 0.6512 GB, free: 11.6 MB / 0.6198 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002964/0.03723, allocations: 3.347 MB / 0.6545 GB, free: 8.152 MB / 0.6198 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003129/0.04036, allocations: 3.302 MB / 0.6577 GB, free: 4.844 MB / 0.6198 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002586/0.04295, allocations: 2.88 MB / 0.6606 GB, free: 1.957 MB / 0.6198 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004523/0.0434, allocations: 0.5156 MB / 0.6611 GB, free: 1.441 MB / 0.6198 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00175/0.04515, allocations: 1.205 MB / 0.6622 GB, free: 240 kB / 0.6198 GB
Notification: Performance of NFScalarize.scalarize: time 0.001778/0.04692, allocations: 2.405 MB / 0.6646 GB, free: 13.82 MB / 0.6355 GB
Notification: Performance of NFVerifyModel.verify: time 0.001242/0.04817, allocations: 1.528 MB / 0.6661 GB, free: 12.29 MB / 0.6355 GB
Notification: Performance of NFConvertDAE.convert: time 0.005157/0.05332, allocations: 7.94 MB / 0.6738 GB, free: 4.332 MB / 0.6355 GB
Notification: Performance of FrontEnd - DAE generated: time 6.673e-06/0.05333, allocations: 4 kB / 0.6738 GB, free: 4.328 MB / 0.6355 GB
Notification: Performance of FrontEnd: time 3.076e-06/0.05333, allocations: 0 / 0.6738 GB, free: 4.328 MB / 0.6355 GB
Notification: Performance of Transformations before backend: time 6.156e-05/0.05339, allocations: 0 / 0.6738 GB, free: 4.328 MB / 0.6355 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 983
 * Number of variables: 983
Notification: Performance of Generate backend data structure: time 0.004805/0.0582, allocations: 3.754 MB / 0.6775 GB, free: 0.5273 MB / 0.6355 GB
Notification: Performance of prepare preOptimizeDAE: time 4.655e-05/0.05825, allocations: 17.41 kB / 0.6775 GB, free: 0.5117 MB / 0.6355 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.287/0.3452, allocations: 0.5404 MB / 0.678 GB, free: 94.22 MB / 0.6355 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006796/0.352, allocations: 2.425 MB / 0.6804 GB, free: 94.09 MB / 0.6355 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002497/0.3545, allocations: 2.149 MB / 0.6825 GB, free: 93.4 MB / 0.6355 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.502e-05/0.3546, allocations: 268.7 kB / 0.6828 GB, free: 93.29 MB / 0.6355 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003729/0.355, allocations: 351.3 kB / 0.6831 GB, free: 93.18 MB / 0.6355 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.006948/0.3619, allocations: 7.204 MB / 0.6901 GB, free: 90.73 MB / 0.6355 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.082e-05/0.362, allocations: 2.781 kB / 0.6901 GB, free: 90.73 MB / 0.6355 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002757/0.3622, allocations: 145.9 kB / 0.6903 GB, free: 90.63 MB / 0.6355 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002337/0.3625, allocations: 344.1 kB / 0.6906 GB, free: 90.58 MB / 0.6355 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007331/0.3698, allocations: 7.02 MB / 0.6975 GB, free: 88.58 MB / 0.6355 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.01467/0.3845, allocations: 18.43 MB / 0.7155 GB, free: 78.2 MB / 0.6355 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004596/0.3891, allocations: 3.715 MB / 0.7191 GB, free: 76.9 MB / 0.6355 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003349/0.3924, allocations: 2.527 MB / 0.7216 GB, free: 76.16 MB / 0.6355 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001509/0.3926, allocations: 47.58 kB / 0.7216 GB, free: 76.15 MB / 0.6355 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.15e-05/0.3926, allocations: 65.31 kB / 0.7217 GB, free: 76.09 MB / 0.6355 GB
Notification: Performance of pre-optimization done (n=208): time 3.717e-06/0.3926, allocations: 0 / 0.7217 GB, free: 76.09 MB / 0.6355 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.05401/0.4466, allocations: 30.75 MB / 0.7517 GB, free: 59.84 MB / 0.6355 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.477e-05/0.4467, allocations: 239.6 kB / 0.7519 GB, free: 59.56 MB / 0.6355 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001102/0.4478, allocations: 1.478 MB / 0.7534 GB, free: 58.07 MB / 0.6355 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001422/0.4479, allocations: 69.7 kB / 0.7534 GB, free: 58 MB / 0.6355 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003194/0.4482, allocations: 1.529 MB / 0.7549 GB, free: 56.46 MB / 0.6355 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0004017/0.4486, allocations: 0.9554 MB / 0.7559 GB, free: 55.52 MB / 0.6355 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000617/0.4492, allocations: 0.632 MB / 0.7565 GB, free: 54.88 MB / 0.6355 GB
Notification: Performance of setup shared object (initialization): time 2.339e-05/0.4493, allocations: 313 kB / 0.7568 GB, free: 54.57 MB / 0.6355 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002945/0.4522, allocations: 2.69 MB / 0.7594 GB, free: 51.88 MB / 0.6355 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003134/0.4554, allocations: 3.65 MB / 0.763 GB, free: 47.83 MB / 0.6355 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006144/0.4615, allocations: 6.407 MB / 0.7692 GB, free: 41.02 MB / 0.6355 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.522e-05/0.4615, allocations: 8 kB / 0.7692 GB, free: 41.02 MB / 0.6355 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.01367/0.4752, allocations: 10.8 MB / 0.7798 GB, free: 30.15 MB / 0.6355 GB
Notification: Performance of prepare postOptimizeDAE: time 2.613e-05/0.4752, allocations: 20 kB / 0.7798 GB, free: 30.13 MB / 0.6355 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.586e-05/0.4752, allocations: 24 kB / 0.7798 GB, free: 30.11 MB / 0.6355 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00931/0.4845, allocations: 5.546 MB / 0.7852 GB, free: 24.55 MB / 0.6355 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00203/0.4866, allocations: 0.9906 MB / 0.7862 GB, free: 23.55 MB / 0.6355 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02254/0.5091, allocations: 27.49 MB / 0.813 GB, free: 11.73 MB / 0.6511 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002841/0.512, allocations: 0.5811 MB / 0.8136 GB, free: 11.15 MB / 0.6511 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002158/0.5122, allocations: 148 kB / 0.8138 GB, free: 11 MB / 0.6511 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.005721/0.5179, allocations: 3.988 MB / 0.8177 GB, free: 7.008 MB / 0.6511 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003749/0.5216, allocations: 3.608 MB / 0.8212 GB, free: 3.004 MB / 0.6511 GB
Error: Initialization problem is structural singular. Please, check the initial conditions.
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0465/0.5681, allocations: 24.48 MB / 0.8451 GB, free: 10.05 MB / 0.6823 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.68e-05/0.5682, allocations: 8 kB / 0.8451 GB, free: 10.05 MB / 0.6823 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.01474/0.5829, allocations: 10.18 MB / 0.855 GB, free: 15.81 MB / 0.698 GB
Notification: Performance of prepare postOptimizeDAE: time 2.81e-05/0.5829, allocations: 22.44 kB / 0.8551 GB, free: 15.79 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.028e-05/0.583, allocations: 28 kB / 0.8551 GB, free: 15.76 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008092/0.591, allocations: 4.313 MB / 0.8593 GB, free: 11.43 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002697/0.5937, allocations: 1.045 MB / 0.8603 GB, free: 10.39 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02278/0.6165, allocations: 26.25 MB / 0.886 GB, free: 15.57 MB / 0.7292 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002704/0.6192, allocations: 0.5499 MB / 0.8865 GB, free: 15.02 MB / 0.7292 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002169/0.6195, allocations: 148 kB / 0.8866 GB, free: 14.87 MB / 0.7292 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.0007545/0.6202, allocations: 408.3 kB / 0.887 GB, free: 14.46 MB / 0.7292 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003597/0.6206, allocations: 202.7 kB / 0.8872 GB, free: 14.27 MB / 0.7292 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.01425/0.6348, allocations: 9.926 MB / 0.8969 GB, free: 4.297 MB / 0.7292 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.874e-05/0.6348, allocations: 31.94 kB / 0.8969 GB, free: 4.266 MB / 0.7292 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.272e-05/0.6349, allocations: 12 kB / 0.8969 GB, free: 4.254 MB / 0.7292 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.961e-05/0.6349, allocations: 23.94 kB / 0.897 GB, free: 4.23 MB / 0.7292 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.02032/0.6552, allocations: 15.36 MB / 0.912 GB, free: 4.762 MB / 0.7448 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.084e-05/0.6552, allocations: 8 kB / 0.912 GB, free: 4.754 MB / 0.7448 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001638/0.6568, allocations: 0.7373 MB / 0.9127 GB, free: 4.016 MB / 0.7448 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.009651/0.6665, allocations: 5.166 MB / 0.9177 GB, free: 14.83 MB / 0.7605 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001984/0.6667, allocations: 79.89 kB / 0.9178 GB, free: 14.75 MB / 0.7605 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02467/0.6914, allocations: 26.55 MB / 0.9437 GB, free: 3.801 MB / 0.7761 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.183e-06/0.6914, allocations: 15.97 kB / 0.9438 GB, free: 3.785 MB / 0.7761 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.7056, allocations: 9.854 MB / 0.9534 GB, free: 9.723 MB / 0.7917 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001016/0.7066, allocations: 0.6585 MB / 0.954 GB, free: 9.062 MB / 0.7917 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002047/0.7068, allocations: 52 kB / 0.9541 GB, free: 9.012 MB / 0.7917 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001693/0.7085, allocations: 0.5147 MB / 0.9546 GB, free: 8.496 MB / 0.7917 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004603/0.709, allocations: 234.6 kB / 0.9548 GB, free: 8.266 MB / 0.7917 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001402/0.7091, allocations: 91.95 kB / 0.9549 GB, free: 8.176 MB / 0.7917 GB
Notification: Performance of sorting global known variables: time 0.00116/0.7103, allocations: 0.9722 MB / 0.9558 GB, free: 7.199 MB / 0.7917 GB
Notification: Performance of sort global known variables: time 8e-08/0.7103, allocations: 0 / 0.9558 GB, free: 7.199 MB / 0.7917 GB
Notification: Performance of remove unused functions: time 0.003757/0.714, allocations: 1.848 MB / 0.9576 GB, free: 5.352 MB / 0.7917 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)}
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 Backend phase and start with SimCode phase: time 0.01424/0.7283, allocations: 10.51 MB / 0.9679 GB, free: 10.62 MB / 0.8073 GB
Notification: Performance of simCode: created initialization part: time 0.2734/1.002, allocations: 12.01 MB / 0.9796 GB, free: 249.1 MB / 0.8073 GB
Notification: Performance of simCode: created event and clocks part: time 1.452e-05/1.002, allocations: 0 / 0.9796 GB, free: 249.1 MB / 0.8073 GB
Notification: Performance of simCode: created simulation system equations: time 0.006621/1.008, allocations: 4.268 MB / 0.9838 GB, free: 248.6 MB / 0.8073 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001571/1.01, allocations: 264 kB / 0.9841 GB, free: 248.6 MB / 0.8073 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 simCode: created linear, non-linear and system jacobian parts: time 0.06154/1.071, allocations: 41.42 MB / 1.025 GB, free: 235.9 MB / 0.8073 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002864/1.074, allocations: 2.272 MB / 1.027 GB, free: 235.3 MB / 0.8073 GB
Notification: Performance of simCode: alias equations: time 0.003395/1.078, allocations: 1.653 MB / 1.028 GB, free: 235.1 MB / 0.8073 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001109/1.079, allocations: 1.203 MB / 1.03 GB, free: 234.1 MB / 0.8073 GB
Notification: Performance of SimCode: time 1.443e-06/1.079, allocations: 4 kB / 1.03 GB, free: 234.1 MB / 0.8073 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.09735/1.176, allocations: 103.4 MB / 1.131 GB, free: 147.5 MB / 0.8073 GB
Notification: Performance of buildModelFMU: Generate platform static: time 10.07/11.24, allocations: 11.52 kB / 1.131 GB, free: 147.5 MB / 0.8073 GB
"
[Timeout remaining time 649]
(rm -f IDEAS_dev_IDEAS.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YD.pipe ; mkfifo IDEAS_dev_IDEAS.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YD.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YD.pipe >> ../files/IDEAS_dev_IDEAS.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YD.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_IDEAS_dev_IDEAS_Electrical_AC_ThreePhasesUnbalanced_Validation_IEEETests_Test4NodesFeeder_BalancedStepDown_YD_fmu --startTime=0 --stopTime=1 --stepSize=0.0004 --timeout=50 --tolerance=1e-06 IDEAS_dev_IDEAS_Electrical_AC_ThreePhasesUnbalanced_Validation_IEEETests_Test4NodesFeeder_BalancedStepDown_YD.fmu > IDEAS_dev_IDEAS.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YD.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 13.924278049729764]
Failed to read output from testmodel.py, exit status != 0:
11.366157616488636 11.373606509 11.318841313
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x72f85ffc0470>