Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N.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.001539/0.001539, allocations: 100.3 kB / 20.51 MB, free: 1.305 MB / 14.72 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.001779/0.001779, allocations: 213.4 kB / 23.81 MB, free: 4.449 MB / 14.72 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 1.448/1.448, allocations: 230.7 MB / 257.6 MB, free: 7.738 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo): time 0.9445/0.9445, allocations: 149.9 MB / 463.9 MB, free: 10.31 MB / 366.1 MB " [Timeout remaining time 179] Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 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: translateModel(IBPSA.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N") translateModel(IBPSA.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.186e-05/2.186e-05, allocations: 2.281 kB / 0.6424 GB, free: 9.578 MB / 478.1 MB Notification: Performance of NFInst.instantiate(IBPSA.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N): time 0.02906/0.02908, allocations: 22.24 MB / 0.6641 GB, free: 3.293 MB / 494.1 MB Notification: Performance of NFInst.instExpressions: time 0.01261/0.04169, allocations: 6.447 MB / 0.6704 GB, free: 12.85 MB / 0.4981 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.00197/0.04366, allocations: 127.1 kB / 0.6705 GB, free: 12.73 MB / 0.4981 GB Notification: Performance of NFTyping.typeComponents: time 0.004326/0.04799, allocations: 1.498 MB / 0.672 GB, free: 11.23 MB / 0.4981 GB Notification: Performance of NFTyping.typeBindings: time 0.004755/0.05274, allocations: 1.958 MB / 0.6739 GB, free: 9.277 MB / 0.4981 GB Notification: Performance of NFTyping.typeClassSections: time 0.003737/0.05648, allocations: 1.455 MB / 0.6753 GB, free: 7.828 MB / 0.4981 GB Notification: Performance of NFFlatten.flatten: time 0.007882/0.06436, allocations: 6.289 MB / 0.6815 GB, free: 1.547 MB / 0.4981 GB Notification: Performance of NFFlatten.resolveConnections: time 0.005343/0.06971, allocations: 2.606 MB / 0.684 GB, free: 14.85 MB / 0.5137 GB Notification: Performance of NFEvalConstants.evaluate: time 0.004334/0.07404, allocations: 2.388 MB / 0.6864 GB, free: 12.46 MB / 0.5137 GB Notification: Performance of NFSimplifyModel.simplify: time 0.004046/0.07809, allocations: 2.223 MB / 0.6885 GB, free: 10.23 MB / 0.5137 GB Notification: Performance of NFPackage.collectConstants: time 0.0008627/0.07895, allocations: 304 kB / 0.6888 GB, free: 9.93 MB / 0.5137 GB Notification: Performance of NFFlatten.collectFunctions: time 0.00236/0.08131, allocations: 0.8227 MB / 0.6896 GB, free: 9.109 MB / 0.5137 GB Notification: Performance of combineBinaries: time 0.006947/0.08826, allocations: 5.511 MB / 0.695 GB, free: 3.555 MB / 0.5137 GB Notification: Performance of replaceArrayConstructors: time 0.003895/0.09215, allocations: 3.371 MB / 0.6983 GB, free: 156 kB / 0.5137 GB Notification: Performance of NFVerifyModel.verify: time 0.00108/0.09323, allocations: 204 kB / 0.6985 GB, free: 15.95 MB / 0.5294 GB Notification: Performance of FrontEnd: time 0.0004273/0.09366, allocations: 51.81 kB / 0.6985 GB, free: 15.9 MB / 0.5294 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1055 (529) * Number of variables: 1053 (372) Notification: Performance of [SIM] Bindings: time 0.0162/0.1099, allocations: 14.02 MB / 0.7122 GB, free: 1.539 MB / 0.5294 GB Notification: Performance of [SIM] FunctionAlias: time 0.001683/0.1115, allocations: 1.548 MB / 0.7137 GB, free: 15.95 MB / 0.545 GB Notification: Performance of [SIM] Early Inline: time 0.01512/0.1267, allocations: 13.93 MB / 0.7273 GB, free: 1.914 MB / 0.545 GB Notification: Performance of [SIM] Simplify 1: time 0.003244/0.1299, allocations: 1.937 MB / 0.7292 GB, free: 15.82 MB / 0.5606 GB Notification: Performance of [SIM] Alias: time 0.01509/0.145, allocations: 11.19 MB / 0.7402 GB, free: 3.52 MB / 0.5606 GB Notification: Performance of [SIM] Simplify 2: time 0.002657/0.1476, allocations: 1.729 MB / 0.7419 GB, free: 1.695 MB / 0.5606 GB Notification: Performance of [SIM] Remove Stream: time 0.001049/0.1487, allocations: 0.8344 MB / 0.7427 GB, free: 0.8047 MB / 0.5606 GB Notification: Performance of [SIM] Detect States: time 0.002192/0.1509, allocations: 2.141 MB / 0.7448 GB, free: 14.6 MB / 0.5762 GB Notification: Performance of [SIM] Events: time 0.0003891/0.1513, allocations: 299.7 kB / 0.745 GB, free: 14.3 MB / 0.5762 GB Notification: Performance of [SIM] Partitioning: time 0.00437/0.1556, allocations: 3.794 MB / 0.7488 GB, free: 10.48 MB / 0.5762 GB Error: Internal error NBResolveSingularities.indexReduction failed because there was not enough state candidates to balance out the constraint equations. Constraint Equations (65/98) ****************************** (1) [FOR-] (3) ($RES_SIM_54) (1) [----] for $i1 in 1:3 loop (1) [----] [ARRY] (1) sc_load3.adaWye.terminal.phase[$i1].theta = sc_load3.adaWye.terminals[$i1].theta ($RES_SIM_55) (1) [----] end for; (2) [SCAL] (1) sc_load1.load3.terminal.theta[1] = sc_load1.adaWye.terminals[3].theta[1] ($RES_SIM_452) (3) [ARRY] (1) sc_load3.terminal.phase[1].theta = sc_load3.terminal.phase[4].theta ($RES_SIM_49) (4) [FOR-] (3) ($RES_SIM_47) (4) [----] for $i1 in 1:3 loop (4) [----] [ARRY] (1) sc_load3.connection3to4.terminal3.phase[$i1].theta = sc_load3.terminal.phase[$i1].theta ($RES_SIM_48) (4) [----] end for; (5) [SCAL] (1) sc_load2.load2.terminal.theta[1] = sc_load2.adaWye.terminals[2].theta[1] ($RES_SIM_418) (6) [FOR-] (3) ($RES_SIM_198) (6) [----] for $i1 in 1:3 loop (6) [----] [ARRY] (1) sc_load1.adaWye.terminal.phase[$i1].theta = sc_load1.adaWye.terminals[$i1].theta ($RES_SIM_199) (6) [----] end for; (7) [SCAL] (1) E.vPhase[1].terminal.theta[1] = E.terminal.phase[1].theta[1] ($RES_SIM_496) (8) [SCAL] (1) sc_load1.load2.theRef = sc_load1.load2.terminal.theta[1] ($RES_SIM_240) (9) [ARRY] (1) Rline_1.terminal_p.phase[1].theta = Rline_1.terminal_p.phase[4].theta ($RES_SIM_193) (10) [FOR-] (3) ($RES_SIM_191) (10) [----] for $i1 in 1:3 loop (10) [----] [ARRY] (1) sc_load1.connection3to4.terminal3.phase[$i1].theta = Rline_1.terminal_p.phase[$i1].theta ($RES_SIM_192) (10) [----] end for; (11) [SCAL] (1) E.vPhase[2].terminal.theta[1] = E.terminal.phase[2].theta[1] ($RES_SIM_493) (12) [SCAL] (1) sc_load2.load3.terminal.theta[1] = sc_load2.adaWye.terminals[3].theta[1] ($RES_SIM_413) (13) [FOR-] (4) ($RES_SIM_36) (13) [----] for $i1 in 1:4 loop (13) [----] [ARRY] (1) Rline_1.terminal_p.phase[$i1].theta = Rline_1.terminal_n.phase[$i1].theta ($RES_SIM_37) (13) [----] end for; (14) [SCAL] (1) sc_load2.load3.theRef = sc_load2.load3.terminal.theta[1] ($RES_SIM_153) (15) [SCAL] (1) E.vPhase[3].terminal.theta[1] = E.terminal.phase[3].theta[1] ($RES_SIM_490) (16) [SCAL] (1) E.terminal.phase[1].theta[1] = Rline_3b.terminal_n.phase[1].theta[1] ($RES_SIM_325) (17) [SCAL] (1) E.ground.terminal.theta[1] = E.terminal.phase[4].theta[1] ($RES_SIM_487) (18) [SCAL] (1) E.terminal.phase[1].theta[1] = Rline_2a.terminal_n.phase[1].theta[1] ($RES_SIM_324) (19) [SCAL] (1) E.terminal.phase[1].theta[1] = Rline_1.terminal_n.phase[1].theta[1] ($RES_SIM_323) (20) [SCAL] (1) E.terminal.phase[2].theta[1] = Rline_3b.terminal_n.phase[2].theta[1] ($RES_SIM_322) (21) [FOR-] (4) ($RES_SIM_28) (21) [----] for $i1 in 1:4 loop (21) [----] [ARRY] (1) Rline_2a.terminal_p.phase[$i1].theta = Rline_2a.terminal_n.phase[$i1].theta ($RES_SIM_29) (21) [----] end for; (22) [SCAL] (1) E.terminal.phase[2].theta[1] = Rline_2a.terminal_n.phase[2].theta[1] ($RES_SIM_321) (23) [SCAL] (1) E.terminal.phase[2].theta[1] = Rline_1.terminal_n.phase[2].theta[1] ($RES_SIM_320) (24) [FOR-] (4) ($RES_SIM_20) (24) [----] for $i1 in 1:4 loop (24) [----] [ARRY] (1) Rline_2b.terminal_p.phase[$i1].theta = Rline_2a.terminal_p.phase[$i1].theta ($RES_SIM_21) (24) [----] end for; (25) [SCAL] (1) E.terminal.phase[3].theta[1] = Rline_3b.terminal_n.phase[3].theta[1] ($RES_SIM_319) (26) [SCAL] (1) E.terminal.phase[3].theta[1] = Rline_2a.terminal_n.phase[3].theta[1] ($RES_SIM_318) (27) [FOR-] (4) ($RES_SIM_12) (27) [----] for $i1 in 1:4 loop (27) [----] [ARRY] (1) Rline_3a.terminal_p.phase[$i1].theta = Rline_3a.terminal_n.phase[$i1].theta ($RES_SIM_13) (27) [----] end for; (28) [SCAL] (1) E.terminal.phase[3].theta[1] = Rline_1.terminal_n.phase[3].theta[1] ($RES_SIM_317) (29) [SCAL] (1) E.terminal.phase[4].theta[1] = Rline_3b.terminal_n.phase[4].theta[1] ($RES_SIM_316) (30) [SCAL] (1) E.terminal.phase[4].theta[1] = Rline_2a.terminal_n.phase[4].theta[1] ($RES_SIM_315) (31) [SCAL] (1) E.terminal.phase[4].theta[1] = Rline_1.terminal_n.phase[4].theta[1] ($RES_SIM_314) (32) [SCAL] (1) Rline_3a.terminal_p.phase[1].theta[1] = sc_load3.terminal.phase[1].theta[1] ($RES_SIM_313) (33) [SCAL] (1) sc_load3.load1.terminal.theta[1] = sc_load3.adaWye.terminals[1].theta[1] ($RES_SIM_384) (34) [SCAL] (1) Rline_3a.terminal_p.phase[1].theta[1] = Rline_3b.terminal_p.phase[1].theta[1] ($RES_SIM_312) (35) [SCAL] (1) Rline_3a.terminal_p.phase[2].theta[1] = sc_load3.terminal.phase[2].theta[1] ($RES_SIM_311) (36) [SCAL] (1) Rline_3a.terminal_p.phase[2].theta[1] = Rline_3b.terminal_p.phase[2].theta[1] ($RES_SIM_310) (37) [SCAL] (1) sc_load2.load1.theRef = sc_load2.load1.terminal.theta[1] ($RES_SIM_183) (38) [SCAL] (1) sc_load1.load3.theRef = sc_load1.load3.terminal.theta[1] ($RES_SIM_225) (39) [SCAL] (1) sc_load3.load2.theRef = sc_load3.load2.terminal.theta[1] ($RES_SIM_96) (40) [ARRY] (1) sc_load2.adaWye.terminal.phase[1].theta = sc_load2.wyeToWyeGround.connection3to4.ground4.theta ($RES_SIM_138) (41) [FOR-] (3) ($RES_SIM_136) (41) [----] for $i1 in 1:3 loop (41) [----] [ARRY] (1) sc_load2.connection3to4.terminal3.phase[$i1].theta = sc_load2.adaWye.terminal.phase[$i1].theta ($RES_SIM_137) (41) [----] end for; (42) [SCAL] (1) Rline_3a.terminal_p.phase[3].theta[1] = sc_load3.terminal.phase[3].theta[1] ($RES_SIM_309) (43) [SCAL] (1) Rline_3a.terminal_p.phase[3].theta[1] = Rline_3b.terminal_p.phase[3].theta[1] ($RES_SIM_308) (44) [SCAL] (1) sc_load1.load1.terminal.theta[1] = sc_load1.adaWye.terminals[1].theta[1] ($RES_SIM_462) (45) [SCAL] (1) Rline_3a.terminal_p.phase[4].theta[1] = sc_load3.terminal.phase[4].theta[1] ($RES_SIM_307) (46) [SCAL] (1) Rline_3a.terminal_p.phase[4].theta[1] = Rline_3b.terminal_p.phase[4].theta[1] ($RES_SIM_306) (47) [SCAL] (1) sc_load3.load2.terminal.theta[1] = sc_load3.adaWye.terminals[2].theta[1] ($RES_SIM_379) (48) [SCAL] (1) E.vPhase[3].terminal.theta[1] = 6.283185307179586 * E.vPhase[3].f * time ($RES_SIM_262) (49) [ARRY] (1) sc_load1.adaWye.terminal.phase[1].theta = sc_load1.wyeToWyeGround.connection3to4.ground4.theta ($RES_SIM_210) (50) [SCAL] (1) sc_load3.load3.theRef = sc_load3.load3.terminal.theta[1] ($RES_SIM_81) (51) [SCAL] (1) E.vPhase[2].terminal.theta[1] = 6.283185307179586 * E.vPhase[2].f * time ($RES_SIM_261) (52) [FOR-] (3) ($RES_SIM_126) (52) [----] for $i1 in 1:3 loop (52) [----] [ARRY] (1) sc_load2.adaWye.terminal.phase[$i1].theta = sc_load2.adaWye.terminals[$i1].theta ($RES_SIM_127) (52) [----] end for; (53) [SCAL] (1) E.vPhase[1].terminal.theta[1] = 6.283185307179586 * E.vPhase[1].f * time ($RES_SIM_260) (54) [ARRY] (1) Rline_2b.terminal_p.phase[1].theta = Rline_2b.terminal_p.phase[4].theta ($RES_SIM_121) (55) [SCAL] (1) sc_load3.load3.terminal.theta[1] = sc_load3.adaWye.terminals[3].theta[1] ($RES_SIM_374) (56) [FOR-] (3) ($RES_SIM_208) (56) [----] for $i1 in 1:3 loop (56) [----] [ARRY] (1) sc_load1.connection3to4.terminal3.phase[$i1].theta = sc_load1.adaWye.terminal.phase[$i1].theta ($RES_SIM_209) (56) [----] end for; (57) [FOR-] (4) ($RES_SIM_4) (57) [----] for $i1 in 1:4 loop (57) [----] [ARRY] (1) Rline_3b.terminal_p.phase[$i1].theta = Rline_3b.terminal_n.phase[$i1].theta ($RES_SIM_5) (57) [----] end for; (58) [FOR-] (3) ($RES_SIM_119) (58) [----] for $i1 in 1:3 loop (58) [----] [ARRY] (1) sc_load2.connection3to4.terminal3.phase[$i1].theta = Rline_2b.terminal_p.phase[$i1].theta ($RES_SIM_120) (58) [----] end for; (59) [SCAL] (1) sc_load3.load1.theRef = sc_load3.load1.terminal.theta[1] ($RES_SIM_111) (60) [SCAL] (1) sc_load2.load1.terminal.theta[1] = sc_load2.adaWye.terminals[1].theta[1] ($RES_SIM_423) (61) [ARRY] (1) sc_load3.adaWye.terminal.phase[1].theta = sc_load3.wyeToWyeGround.connection3to4.ground4.theta ($RES_SIM_66) (62) [FOR-] (3) ($RES_SIM_64) (62) [----] for $i1 in 1:3 loop (62) [----] [ARRY] (1) sc_load3.connection3to4.terminal3.phase[$i1].theta = sc_load3.adaWye.terminal.phase[$i1].theta ($RES_SIM_65) (62) [----] end for; (63) [SCAL] (1) sc_load2.load2.theRef = sc_load2.load2.terminal.theta[1] ($RES_SIM_168) (64) [SCAL] (1) sc_load1.load1.theRef = sc_load1.load1.terminal.theta[1] ($RES_SIM_255) (65) [SCAL] (1) sc_load1.load2.terminal.theta[1] = sc_load1.adaWye.terminals[2].theta[1] ($RES_SIM_457) State Candidate Variables (43/96) *********************************** (1) [ALGB] (3) protected Real[3, 1] sc_load1.adaWye.terminal.phase.theta (2) [ALGB] (4) Real[4, 1] E.terminal.phase.theta (3) [ALGB] (4) Real[4, 1] Rline_2b.terminal_p.phase.theta (4) [ALGB] (3) protected Real[3, 1] sc_load2.adaWye.terminal.phase.theta (5) [ALGB] (4) Real[4, 1] Rline_2a.terminal_p.phase.theta (6) [ALGB] (3) protected Real[3, 1] sc_load3.adaWye.terminal.phase.theta (7) [ALGB] (1) Real[1] sc_load3.load3.terminal.theta (8) [ALGB] (1) Real[1] sc_load2.load3.terminal.theta (9) [ALGB] (1) Real[1] sc_load1.load3.terminal.theta (10) [ALGB] (4) Real[4, 1] Rline_2a.terminal_n.phase.theta (11) [ALGB] (3) Real[3, 1] sc_load1.connection3to4.terminal3.phase.theta (12) [ALGB] (3) Real[3, 1] sc_load2.connection3to4.terminal3.phase.theta (13) [ALGB] (3) Real[3, 1] sc_load3.connection3to4.terminal3.phase.theta (14) [ALGB] (3) Real[3, 1] E.vPhase.terminal.theta (15) [STAT] (1) protected Real sc_load3.load1.theRef (16) [STAT] (1) protected Real sc_load2.load1.theRef (17) [ALGB] (1) Real[1] sc_load3.load1.terminal.theta (18) [ALGB] (1) Real[1] sc_load2.load1.terminal.theta (19) [STAT] (1) protected Real sc_load1.load1.theRef (20) [ALGB] (1) Real[1] sc_load1.load1.terminal.theta (21) [ALGB] (3) protected Real[3, 1] sc_load3.adaWye.terminals.theta (22) [ALGB] (4) Real[4, 1] Rline_1.terminal_n.phase.theta (23) [ALGB] (3) protected Real[3, 1] sc_load2.adaWye.terminals.theta (24) [STAT] (1) protected Real sc_load3.load3.theRef (25) [STAT] (1) protected Real sc_load2.load3.theRef (26) [ALGB] (3) protected Real[3, 1] sc_load1.adaWye.terminals.theta (27) [STAT] (1) protected Real sc_load1.load3.theRef (28) [ALGB] (1) Real[1] E.ground.terminal.theta (29) [ALGB] (4) Real[4, 1] Rline_3b.terminal_p.phase.theta (30) [ALGB] (4) Real[4, 1] Rline_3a.terminal_p.phase.theta (31) [ALGB] (4) Real[4, 1] Rline_1.terminal_p.phase.theta (32) [ALGB] (4) Real[4, 1] Rline_3b.terminal_n.phase.theta (33) [ALGB] (4) Real[4, 1] Rline_3a.terminal_n.phase.theta (34) [ALGB] (1) Real[1] sc_load3.load2.terminal.theta (35) [ALGB] (1) Real[1] sc_load2.load2.terminal.theta (36) [ALGB] (1) Real[1] sc_load1.load2.terminal.theta (37) [STAT] (1) protected Real sc_load3.load2.theRef (38) [ALGB] (4) Real[4, 1] sc_load3.terminal.phase.theta (39) [STAT] (1) protected Real sc_load2.load2.theRef (40) [STAT] (1) protected Real sc_load1.load2.theRef (41) [ALGB] (1) Real[1] sc_load1.wyeToWyeGround.connection3to4.ground4.theta (42) [ALGB] (1) Real[1] sc_load2.wyeToWyeGround.connection3to4.ground4.theta (43) [ALGB] (1) Real[1] sc_load3.wyeToWyeGround.connection3to4.ground4.theta " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 3.9678394329966977] Failed to read output from testmodel.py, exit status != 0: 0.45720598596381024 0.467621462 0.371119057 Calling exit ...