Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_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.001488/0.001488, allocations: 74.72 kB / 19.96 MB, free: 1.453 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.00158/0.00158, allocations: 171 kB / 23.23 MB, free: 4.195 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.266/1.266, allocations: 177.2 MB / 203.6 MB, free: 8.227 MB / 190.1 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/package.mo", uses=false) [Timeout 180] "[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Examples/PPD12/Structure.mo:531:21-531:686:writable] Warning: Lexer treating \\ as \\\\, since \\e is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Examples/PPD12/Structure.mo:531:21-531:694:writable] Warning: Lexer treating \\ as \\\\, since \\< is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Media/Refrigerants/R410A/package.order:0:0-0:0:readonly] Warning: Found duplicate names in package.order file: A, B, C. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Media/Refrigerants/R410A/package.mo:2:1-70:10:writable] Warning: C was referenced in the package.order file, but was not found in package.mo, C/package.mo or C.mo. Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/package.mo): time 1.118/1.118, allocations: 154.7 MB / 414.7 MB, free: 6.52 MB / 382.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/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 4.0.0/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 4.0.0/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_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_IDEAS.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.444e-05/1.444e-05, allocations: 2.281 kB / 0.6195 GB, free: 4.367 MB / 0.5137 GB Notification: Performance of NFInst.instantiate(IDEAS.Electrical.AC.ThreePhasesUnbalanced.Lines.Examples.ACLineMatrix_RL_N): time 0.02595/0.02597, allocations: 21.81 MB / 0.6408 GB, free: 14.52 MB / 0.545 GB Notification: Performance of NFInst.instExpressions: time 0.01095/0.03692, allocations: 6.397 MB / 0.6471 GB, free: 8.125 MB / 0.545 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001297/0.03822, allocations: 127.1 kB / 0.6472 GB, free: 8 MB / 0.545 GB Notification: Performance of NFTyping.typeComponents: time 0.003691/0.04191, allocations: 1.509 MB / 0.6487 GB, free: 6.492 MB / 0.545 GB Notification: Performance of NFTyping.typeBindings: time 0.004216/0.04612, allocations: 1.953 MB / 0.6506 GB, free: 4.543 MB / 0.545 GB Notification: Performance of NFTyping.typeClassSections: time 0.003324/0.04945, allocations: 1.463 MB / 0.652 GB, free: 3.082 MB / 0.545 GB Notification: Performance of NFFlatten.flatten: time 0.007146/0.05659, allocations: 6.292 MB / 0.6582 GB, free: 12.82 MB / 0.5606 GB Notification: Performance of NFFlatten.resolveConnections: time 0.004192/0.06079, allocations: 2.624 MB / 0.6607 GB, free: 10.11 MB / 0.5606 GB Notification: Performance of NFEvalConstants.evaluate: time 0.004252/0.06504, allocations: 3.142 MB / 0.6638 GB, free: 6.961 MB / 0.5606 GB Notification: Performance of NFSimplifyModel.simplify: time 0.002891/0.06793, allocations: 2.073 MB / 0.6658 GB, free: 4.883 MB / 0.5606 GB Notification: Performance of NFPackage.collectConstants: time 0.0004275/0.06836, allocations: 300 kB / 0.6661 GB, free: 4.59 MB / 0.5606 GB Notification: Performance of NFFlatten.collectFunctions: time 0.001568/0.06992, allocations: 0.8265 MB / 0.6669 GB, free: 3.762 MB / 0.5606 GB Notification: Performance of combineBinaries: time 0.004804/0.07473, allocations: 5.01 MB / 0.6718 GB, free: 14.71 MB / 0.5762 GB Notification: Performance of replaceArrayConstructors: time 0.002636/0.07736, allocations: 3.012 MB / 0.6747 GB, free: 11.68 MB / 0.5762 GB Notification: Performance of NFVerifyModel.verify: time 0.0004228/0.07779, allocations: 204 kB / 0.6749 GB, free: 11.48 MB / 0.5762 GB Notification: Performance of FrontEnd: time 0.0002304/0.07802, allocations: 55.81 kB / 0.675 GB, free: 11.42 MB / 0.5762 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.01389/0.09191, allocations: 13.78 MB / 0.6884 GB, free: 13.3 MB / 0.5919 GB Notification: Performance of [SIM] FunctionAlias: time 0.002854/0.09476, allocations: 2.475 MB / 0.6909 GB, free: 11 MB / 0.5919 GB Notification: Performance of [SIM] Early Inline: time 0.01769/0.1125, allocations: 16.21 MB / 0.7067 GB, free: 10.86 MB / 0.6075 GB Notification: Performance of [SIM] Simplify 1: time 0.003219/0.1157, allocations: 1.796 MB / 0.7084 GB, free: 8.93 MB / 0.6075 GB Notification: Performance of [SIM] Alias: time 0.01601/0.1317, allocations: 12.47 MB / 0.7206 GB, free: 11.15 MB / 0.6231 GB Notification: Performance of [SIM] Simplify 2: time 0.002543/0.1342, allocations: 1.628 MB / 0.7222 GB, free: 9.379 MB / 0.6231 GB Notification: Performance of [SIM] Remove Stream: time 0.00129/0.1355, allocations: 1.002 MB / 0.7232 GB, free: 8.281 MB / 0.6231 GB Notification: Performance of [SIM] Detect States: time 0.003529/0.139, allocations: 3.388 MB / 0.7265 GB, free: 4.785 MB / 0.6231 GB Notification: Performance of [SIM] Events: time 0.0004258/0.1395, allocations: 331.7 kB / 0.7268 GB, free: 4.461 MB / 0.6231 GB Notification: Performance of [SIM] Partitioning: time 0.005678/0.1451, allocations: 4.88 MB / 0.7316 GB, free: 15.39 MB / 0.6387 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: 3.5367872305214405] Failed to read output from testmodel.py, exit status != 0: 0.1684102974832058 0.182147103 0.10112620600000001 Calling exit ...