Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.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.0009713/0.0009713, allocations: 80.25 kB / 20.05 MB, free: 4.469 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.0007842/0.0007842, allocations: 178.3 kB / 23.36 MB, free: 1.16 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.8444/0.8444, allocations: 177.1 MB / 203.7 MB, free: 5.715 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-535:34: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-535:42: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.6607/0.6607, allocations: 154.5 MB / 414.7 MB, free: 0.793 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: translateModel(IDEAS.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N") translateModel(IDEAS.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.653e-05/2.653e-05, allocations: 2.312 kB / 0.6196 GB, free: 13.13 MB / 0.5886 GB Notification: Performance of NFInst.instantiate(IDEAS.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N): time 0.01605/0.01607, allocations: 21.81 MB / 0.6409 GB, free: 7.238 MB / 0.6042 GB Notification: Performance of NFInst.instExpressions: time 0.008776/0.02485, allocations: 6.41 MB / 0.6471 GB, free: 0.8047 MB / 0.6042 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.00171/0.02656, allocations: 127.1 kB / 0.6472 GB, free: 0.6797 MB / 0.6042 GB Notification: Performance of NFTyping.typeComponents: time 0.002138/0.0287, allocations: 1.511 MB / 0.6487 GB, free: 15.16 MB / 0.6198 GB Notification: Performance of NFTyping.typeBindings: time 0.00324/0.03194, allocations: 1.982 MB / 0.6507 GB, free: 13.17 MB / 0.6198 GB Notification: Performance of NFTyping.typeClassSections: time 0.002312/0.03425, allocations: 1.469 MB / 0.6521 GB, free: 11.7 MB / 0.6198 GB Notification: Performance of NFFlatten.flatten: time 0.004943/0.03919, allocations: 6.388 MB / 0.6583 GB, free: 5.289 MB / 0.6198 GB Notification: Performance of NFFlatten.resolveConnections: time 0.003279/0.04247, allocations: 2.621 MB / 0.6609 GB, free: 2.574 MB / 0.6198 GB Notification: Performance of NFEvalConstants.evaluate: time 0.003139/0.04561, allocations: 3.161 MB / 0.664 GB, free: 15.41 MB / 0.6355 GB Notification: Performance of NFSimplifyModel.simplify: time 0.001922/0.04753, allocations: 2.085 MB / 0.666 GB, free: 13.32 MB / 0.6355 GB Notification: Performance of NFPackage.collectConstants: time 0.0002836/0.04782, allocations: 300 kB / 0.6663 GB, free: 13.02 MB / 0.6355 GB Notification: Performance of NFFlatten.collectFunctions: time 0.001127/0.04894, allocations: 0.8342 MB / 0.6671 GB, free: 12.19 MB / 0.6355 GB Notification: Performance of combineBinaries: time 0.002718/0.05166, allocations: 5.041 MB / 0.672 GB, free: 7.109 MB / 0.6355 GB Notification: Performance of replaceArrayConstructors: time 0.001326/0.05299, allocations: 3.034 MB / 0.675 GB, free: 4.051 MB / 0.6355 GB Notification: Performance of NFVerifyModel.verify: time 0.0002543/0.05324, allocations: 200 kB / 0.6752 GB, free: 3.855 MB / 0.6355 GB Notification: Performance of FrontEnd: time 0.0001175/0.05336, allocations: 51.88 kB / 0.6752 GB, free: 3.805 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: 1055 (529) * Number of variables: 1053 (372) Notification: Performance of [SIM] Bindings: time 0.2902/0.3436, allocations: 13.78 MB / 0.6887 GB, free: 66.79 MB / 0.6355 GB Notification: Performance of [SIM] FunctionAlias: time 0.002075/0.3457, allocations: 2.489 MB / 0.6911 GB, free: 66.61 MB / 0.6355 GB Notification: Performance of [SIM] Early Inline: time 0.009776/0.3555, allocations: 16.28 MB / 0.707 GB, free: 58.96 MB / 0.6355 GB Notification: Performance of [SIM] Simplify 1: time 0.002153/0.3576, allocations: 1.579 MB / 0.7086 GB, free: 58.45 MB / 0.6355 GB Notification: Performance of [SIM] Alias: time 0.01216/0.3698, allocations: 12.65 MB / 0.7209 GB, free: 51.58 MB / 0.6355 GB Notification: Performance of [SIM] Simplify 2: time 0.002615/0.3724, allocations: 1.455 MB / 0.7223 GB, free: 51.07 MB / 0.6355 GB Notification: Performance of [SIM] Remove Stream: time 0.002522/0.3749, allocations: 1 MB / 0.7233 GB, free: 50.46 MB / 0.6355 GB Notification: Performance of [SIM] Detect States: time 0.00442/0.3793, allocations: 3.401 MB / 0.7266 GB, free: 48.66 MB / 0.6355 GB Notification: Performance of [SIM] Events: time 0.00045/0.3798, allocations: 330.7 kB / 0.727 GB, free: 48.52 MB / 0.6355 GB Notification: Performance of [SIM] Partitioning: time 0.00435/0.3841, allocations: 4.879 MB / 0.7317 GB, free: 46.19 MB / 0.6355 GB Error: Internal error NBResolveSingularities.indexReduction failed because there was not enough state candidates to balance out the constraint equations. Constraint Equations (63/93) ****************************** (1) [SCAL] (1) E.terminal.phase[3].theta[1] = Rline_3b.terminal_n.phase[3].theta[1] ($RES_SIM_319) (2) [SCAL] (1) E.terminal.phase[3].theta[1] = Rline_2a.terminal_n.phase[3].theta[1] ($RES_SIM_318) (3) [SCAL] (1) E.terminal.phase[3].theta[1] = Rline_1.terminal_n.phase[3].theta[1] ($RES_SIM_317) (4) [SCAL] (1) E.terminal.phase[4].theta[1] = Rline_3b.terminal_n.phase[4].theta[1] ($RES_SIM_316) (5) [SCAL] (1) E.terminal.phase[4].theta[1] = Rline_2a.terminal_n.phase[4].theta[1] ($RES_SIM_315) (6) [SCAL] (1) E.terminal.phase[4].theta[1] = Rline_1.terminal_n.phase[4].theta[1] ($RES_SIM_314) (7) [SCAL] (1) Rline_3a.terminal_p.phase[1].theta[1] = sc_load3.terminal.phase[1].theta[1] ($RES_SIM_313) (8) [SCAL] (1) Rline_3a.terminal_p.phase[1].theta[1] = Rline_3b.terminal_p.phase[1].theta[1] ($RES_SIM_312) (9) [SCAL] (1) Rline_3a.terminal_p.phase[2].theta[1] = sc_load3.terminal.phase[2].theta[1] ($RES_SIM_311) (10) [SCAL] (1) Rline_3a.terminal_p.phase[2].theta[1] = Rline_3b.terminal_p.phase[2].theta[1] ($RES_SIM_310) (11) [SCAL] (1) sc_load3.load1.terminal.theta[1] = sc_load3.adaWye.terminals[1].theta[1] ($RES_SIM_384) (12) [FOR-] (3) ($RES_SIM_136) (12) [----] for $i1 in 1:3 loop (12) [----] [ARRY] (1) sc_load2.connection3to4.terminal3.phase[$i1].theta = sc_load2.adaWye.terminal.phase[$i1].theta ($RES_SIM_137) (12) [----] end for; (13) [SCAL] (1) Rline_3a.terminal_p.phase[3].theta[1] = sc_load3.terminal.phase[3].theta[1] ($RES_SIM_309) (14) [SCAL] (1) Rline_3a.terminal_p.phase[3].theta[1] = Rline_3b.terminal_p.phase[3].theta[1] ($RES_SIM_308) (15) [SCAL] (1) Rline_3a.terminal_p.phase[4].theta[1] = sc_load3.terminal.phase[4].theta[1] ($RES_SIM_307) (16) [SCAL] (1) Rline_3a.terminal_p.phase[4].theta[1] = Rline_3b.terminal_p.phase[4].theta[1] ($RES_SIM_306) (17) [SCAL] (1) $FUN_1 = 6.283185307179586 * E.vPhase[3].f * time ($RES_SIM_262) (18) [SCAL] (1) $FUN_2 = 6.283185307179586 * E.vPhase[2].f * time ($RES_SIM_261) (19) [SCAL] (1) $FUN_3 = 6.283185307179586 * E.vPhase[1].f * time ($RES_SIM_260) (20) [SCAL] (1) sc_load1.load1.theRef = sc_load1.load1.terminal.theta[1] ($RES_AUX_699) (21) [SCAL] (1) sc_load1.load2.theRef = sc_load1.load2.terminal.theta[1] ($RES_AUX_698) (22) [SCAL] (1) sc_load1.load3.theRef = sc_load1.load3.terminal.theta[1] ($RES_AUX_697) (23) [SCAL] (1) sc_load2.load1.theRef = sc_load2.load1.terminal.theta[1] ($RES_AUX_696) (24) [SCAL] (1) sc_load2.load2.theRef = sc_load2.load2.terminal.theta[1] ($RES_AUX_695) (25) [SCAL] (1) sc_load2.load3.theRef = sc_load2.load3.terminal.theta[1] ($RES_AUX_694) (26) [SCAL] (1) sc_load3.load2.terminal.theta[1] = sc_load3.adaWye.terminals[2].theta[1] ($RES_SIM_379) (27) [SCAL] (1) sc_load3.load1.theRef = sc_load3.load1.terminal.theta[1] ($RES_AUX_693) (28) [SCAL] (1) sc_load1.load1.terminal.theta[1] = sc_load1.adaWye.terminals[1].theta[1] ($RES_SIM_462) (29) [SCAL] (1) sc_load3.load2.theRef = sc_load3.load2.terminal.theta[1] ($RES_AUX_692) (30) [FOR-] (3) ($RES_SIM_126) (30) [----] for $i1 in 1:3 loop (30) [----] [ARRY] (1) sc_load2.adaWye.terminal.phase[$i1].theta = sc_load2.adaWye.terminals[$i1].theta ($RES_SIM_127) (30) [----] end for; (31) [SCAL] (1) sc_load3.load3.theRef = sc_load3.load3.terminal.theta[1] ($RES_AUX_691) (32) [ARRY] (1) sc_load3.terminal.phase[1].theta = sc_load3.terminal.phase[4].theta ($RES_SIM_49) (33) [FOR-] (3) ($RES_SIM_47) (33) [----] for $i1 in 1:3 loop (33) [----] [ARRY] (1) sc_load3.connection3to4.terminal3.phase[$i1].theta = sc_load3.terminal.phase[$i1].theta ($RES_SIM_48) (33) [----] end for; (34) [ARRY] (1) Rline_2b.terminal_p.phase[1].theta = Rline_2b.terminal_p.phase[4].theta ($RES_SIM_121) (35) [SCAL] (1) sc_load2.load1.terminal.theta[1] = sc_load2.adaWye.terminals[1].theta[1] ($RES_SIM_423) (36) [SCAL] (1) sc_load3.load3.terminal.theta[1] = sc_load3.adaWye.terminals[3].theta[1] ($RES_SIM_374) (37) [FOR-] (3) ($RES_SIM_208) (37) [----] for $i1 in 1:3 loop (37) [----] [ARRY] (1) sc_load1.connection3to4.terminal3.phase[$i1].theta = sc_load1.adaWye.terminal.phase[$i1].theta ($RES_SIM_209) (37) [----] end for; (38) [SCAL] (1) $FUN_1 = E.vPhase[3].terminal.theta[1] ($RES_AUX_706) (39) [SCAL] (1) $FUN_2 = E.vPhase[2].terminal.theta[1] ($RES_AUX_705) (40) [SCAL] (1) E.vPhase[1].terminal.theta[1] = E.terminal.phase[1].theta[1] ($RES_SIM_496) (41) [SCAL] (1) $FUN_3 = E.vPhase[1].terminal.theta[1] ($RES_AUX_704) (42) [FOR-] (4) ($RES_SIM_36) (42) [----] for $i1 in 1:4 loop (42) [----] [ARRY] (1) Rline_1.terminal_p.phase[$i1].theta = Rline_1.terminal_n.phase[$i1].theta ($RES_SIM_37) (42) [----] end for; (43) [SCAL] (1) E.vPhase[2].terminal.theta[1] = E.terminal.phase[2].theta[1] ($RES_SIM_493) (44) [FOR-] (3) ($RES_SIM_119) (44) [----] for $i1 in 1:3 loop (44) [----] [ARRY] (1) sc_load2.connection3to4.terminal3.phase[$i1].theta = Rline_2b.terminal_p.phase[$i1].theta ($RES_SIM_120) (44) [----] end for; (45) [SCAL] (1) E.vPhase[3].terminal.theta[1] = E.terminal.phase[3].theta[1] ($RES_SIM_490) (46) [FOR-] (4) ($RES_SIM_28) (46) [----] for $i1 in 1:4 loop (46) [----] [ARRY] (1) Rline_2a.terminal_p.phase[$i1].theta = Rline_2a.terminal_n.phase[$i1].theta ($RES_SIM_29) (46) [----] end for; (47) [FOR-] (4) ($RES_SIM_20) (47) [----] for $i1 in 1:4 loop (47) [----] [ARRY] (1) Rline_2b.terminal_p.phase[$i1].theta = Rline_2a.terminal_p.phase[$i1].theta ($RES_SIM_21) (47) [----] end for; (48) [SCAL] (1) sc_load2.load2.terminal.theta[1] = sc_load2.adaWye.terminals[2].theta[1] ($RES_SIM_418) (49) [FOR-] (3) ($RES_SIM_198) (49) [----] for $i1 in 1:3 loop (49) [----] [ARRY] (1) sc_load1.adaWye.terminal.phase[$i1].theta = sc_load1.adaWye.terminals[$i1].theta ($RES_SIM_199) (49) [----] end for; (50) [FOR-] (4) ($RES_SIM_4) (50) [----] for $i1 in 1:4 loop (50) [----] [ARRY] (1) Rline_3b.terminal_p.phase[$i1].theta = Rline_3b.terminal_n.phase[$i1].theta ($RES_SIM_5) (50) [----] end for; (51) [ARRY] (1) Rline_1.terminal_p.phase[1].theta = Rline_1.terminal_p.phase[4].theta ($RES_SIM_193) (52) [FOR-] (3) ($RES_SIM_191) (52) [----] for $i1 in 1:3 loop (52) [----] [ARRY] (1) sc_load1.connection3to4.terminal3.phase[$i1].theta = Rline_1.terminal_p.phase[$i1].theta ($RES_SIM_192) (52) [----] end for; (53) [SCAL] (1) sc_load2.load3.terminal.theta[1] = sc_load2.adaWye.terminals[3].theta[1] ($RES_SIM_413) (54) [SCAL] (1) sc_load1.load2.terminal.theta[1] = sc_load1.adaWye.terminals[2].theta[1] ($RES_SIM_457) (55) [SCAL] (1) E.terminal.phase[1].theta[1] = Rline_3b.terminal_n.phase[1].theta[1] ($RES_SIM_325) (56) [SCAL] (1) sc_load1.load3.terminal.theta[1] = sc_load1.adaWye.terminals[3].theta[1] ($RES_SIM_452) (57) [SCAL] (1) E.terminal.phase[1].theta[1] = Rline_2a.terminal_n.phase[1].theta[1] ($RES_SIM_324) (58) [FOR-] (3) ($RES_SIM_64) (58) [----] for $i1 in 1:3 loop (58) [----] [ARRY] (1) sc_load3.connection3to4.terminal3.phase[$i1].theta = sc_load3.adaWye.terminal.phase[$i1].theta ($RES_SIM_65) (58) [----] end for; (59) [SCAL] (1) E.terminal.phase[1].theta[1] = Rline_1.terminal_n.phase[1].theta[1] ($RES_SIM_323) (60) [SCAL] (1) E.terminal.phase[2].theta[1] = Rline_3b.terminal_n.phase[2].theta[1] ($RES_SIM_322) (61) [SCAL] (1) E.terminal.phase[2].theta[1] = Rline_2a.terminal_n.phase[2].theta[1] ($RES_SIM_321) (62) [FOR-] (3) ($RES_SIM_54) (62) [----] for $i1 in 1:3 loop (62) [----] [ARRY] (1) sc_load3.adaWye.terminal.phase[$i1].theta = sc_load3.adaWye.terminals[$i1].theta ($RES_SIM_55) (62) [----] end for; (63) [SCAL] (1) E.terminal.phase[2].theta[1] = Rline_1.terminal_n.phase[2].theta[1] ($RES_SIM_320) State Candidate Variables (41/91) *********************************** (1) [ALGB] (1) Real $FUN_3 (2) [ALGB] (1) Real $FUN_2 (3) [ALGB] (1) Real $FUN_1 (4) [ALGB] (4) Real[4, 1] E.terminal.phase.theta (5) [ALGB] (3) protected Real[3, 1] sc_load1.adaWye.terminal.phase.theta (6) [ALGB] (3) protected Real[3, 1] sc_load2.adaWye.terminal.phase.theta (7) [ALGB] (4) Real[4, 1] Rline_2b.terminal_p.phase.theta (8) [ALGB] (4) Real[4, 1] Rline_2a.terminal_p.phase.theta (9) [ALGB] (3) protected Real[3, 1] sc_load3.adaWye.terminal.phase.theta (10) [ALGB] (1) Real[1] sc_load3.load3.terminal.theta (11) [ALGB] (1) Real[1] sc_load2.load3.terminal.theta (12) [ALGB] (1) Real[1] sc_load1.load3.terminal.theta (13) [ALGB] (4) Real[4, 1] Rline_2a.terminal_n.phase.theta (14) [ALGB] (3) Real[3, 1] sc_load1.connection3to4.terminal3.phase.theta (15) [ALGB] (3) Real[3, 1] sc_load2.connection3to4.terminal3.phase.theta (16) [ALGB] (3) Real[3, 1] sc_load3.connection3to4.terminal3.phase.theta (17) [STAT] (1) protected Real sc_load3.load1.theRef (18) [ALGB] (3) Real[3, 1] E.vPhase.terminal.theta (19) [STAT] (1) protected Real sc_load2.load1.theRef (20) [ALGB] (1) Real[1] sc_load3.load1.terminal.theta (21) [ALGB] (1) Real[1] sc_load2.load1.terminal.theta (22) [STAT] (1) protected Real sc_load1.load1.theRef (23) [ALGB] (1) Real[1] sc_load1.load1.terminal.theta (24) [ALGB] (3) protected Real[3, 1] sc_load3.adaWye.terminals.theta (25) [ALGB] (4) Real[4, 1] Rline_1.terminal_n.phase.theta (26) [ALGB] (3) protected Real[3, 1] sc_load2.adaWye.terminals.theta (27) [STAT] (1) protected Real sc_load3.load3.theRef (28) [STAT] (1) protected Real sc_load2.load3.theRef (29) [ALGB] (3) protected Real[3, 1] sc_load1.adaWye.terminals.theta (30) [STAT] (1) protected Real sc_load1.load3.theRef (31) [ALGB] (4) Real[4, 1] Rline_3b.terminal_p.phase.theta (32) [ALGB] (4) Real[4, 1] Rline_3a.terminal_p.phase.theta (33) [ALGB] (4) Real[4, 1] Rline_1.terminal_p.phase.theta (34) [ALGB] (4) Real[4, 1] Rline_3b.terminal_n.phase.theta (35) [ALGB] (1) Real[1] sc_load3.load2.terminal.theta (36) [ALGB] (1) Real[1] sc_load2.load2.terminal.theta (37) [ALGB] (1) Real[1] sc_load1.load2.terminal.theta (38) [STAT] (1) protected Real sc_load3.load2.theRef (39) [STAT] (1) protected Real sc_load2.load2.theRef (40) [ALGB] (4) Real[4, 1] sc_load3.terminal.phase.theta (41) [STAT] (1) protected Real sc_load1.load2.theRef " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 2.8024097215384245] Failed to read output from testmodel.py, exit status != 0: 0.403677792288363 0.40933096099999994 0.35463766899999993 Calling exit ...