Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.Electrical.AC.OnePhase.Lines.Examples.ACLine_L.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.0007453/0.0007453, 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.0007687/0.0007687, 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.7996/0.7996, allocations: 177.1 MB / 203.7 MB, free: 5.227 MB / 186.7 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-545:108: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-545:116: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 0.6493/0.6493, allocations: 154.6 MB / 414.7 MB, free: 0.6992 MB / 378.7 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.OnePhase.Lines.Examples.ACLine_L,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Electrical.AC.OnePhase.Lines.Examples.ACLine_L")
translateModel(IDEAS.Electrical.AC.OnePhase.Lines.Examples.ACLine_L,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Electrical.AC.OnePhase.Lines.Examples.ACLine_L") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.957e-05/1.957e-05, allocations: 2.312 kB / 0.6196 GB, free: 13 MB / 0.5886 GB
Notification: Performance of NFInst.instantiate(IDEAS.Electrical.AC.OnePhase.Lines.Examples.ACLine_L): time 0.004871/0.004891, allocations: 5.804 MB / 0.6253 GB, free: 7.168 MB / 0.5886 GB
Notification: Performance of NFInst.instExpressions: time 0.003372/0.008262, allocations: 3.086 MB / 0.6283 GB, free: 4.07 MB / 0.5886 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003575/0.00862, allocations: 43.62 kB / 0.6283 GB, free: 4.027 MB / 0.5886 GB
Notification: Performance of NFTyping.typeComponents: time 0.001224/0.009844, allocations: 0.9374 MB / 0.6292 GB, free: 3.086 MB / 0.5886 GB
Notification: Performance of NFTyping.typeBindings: time 0.0009169/0.01076, allocations: 0.4931 MB / 0.6297 GB, free: 2.59 MB / 0.5886 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0009265/0.01169, allocations: 486.5 kB / 0.6302 GB, free: 2.113 MB / 0.5886 GB
Notification: Performance of NFFlatten.flatten: time 0.001331/0.01302, allocations: 1.432 MB / 0.6316 GB, free: 0.6758 MB / 0.5886 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0007744/0.01379, allocations: 473.2 kB / 0.632 GB, free: 212 kB / 0.5886 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001101/0.01489, allocations: 0.7832 MB / 0.6328 GB, free: 15.42 MB / 0.6042 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.000462/0.01536, allocations: 326.9 kB / 0.6331 GB, free: 15.1 MB / 0.6042 GB
Notification: Performance of NFPackage.collectConstants: time 6.142e-05/0.01542, allocations: 52 kB / 0.6331 GB, free: 15.05 MB / 0.6042 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.000576/0.01599, allocations: 390.8 kB / 0.6335 GB, free: 14.67 MB / 0.6042 GB
Notification: Performance of combineBinaries: time 0.000656/0.01665, allocations: 1.242 MB / 0.6347 GB, free: 13.41 MB / 0.6042 GB
Notification: Performance of replaceArrayConstructors: time 0.0004612/0.01711, allocations: 0.8138 MB / 0.6355 GB, free: 12.59 MB / 0.6042 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001237/0.01723, allocations: 64 kB / 0.6356 GB, free: 12.53 MB / 0.6042 GB
Notification: Performance of FrontEnd: time 6.537e-05/0.0173, allocations: 15.94 kB / 0.6356 GB, free: 12.52 MB / 0.6042 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 177 (139)
 * Number of variables: 177 (130)
Notification: Performance of [SIM] Bindings: time 0.002161/0.01946, allocations: 3.163 MB / 0.6387 GB, free: 9.176 MB / 0.6042 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0004989/0.01996, allocations: 0.5112 MB / 0.6392 GB, free: 8.676 MB / 0.6042 GB
Notification: Performance of [SIM] Early Inline: time 0.001757/0.02172, allocations: 2.454 MB / 0.6416 GB, free: 6.203 MB / 0.6042 GB
Notification: Performance of [SIM] Simplify 1: time 0.000327/0.02204, allocations: 284 kB / 0.6419 GB, free: 5.887 MB / 0.6042 GB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.002948/0.02499, allocations: 3.736 MB / 0.6455 GB, free: 1.512 MB / 0.6042 GB
Notification: Performance of [SIM] Simplify 2: time 0.0002111/0.0252, allocations: 208 kB / 0.6457 GB, free: 1.281 MB / 0.6042 GB
Notification: Performance of [SIM] Remove Stream: time 0.0001221/0.02533, allocations: 172.1 kB / 0.6459 GB, free: 1.086 MB / 0.6042 GB
Notification: Performance of [SIM] Detect States: time 0.0004533/0.02578, allocations: 0.5636 MB / 0.6464 GB, free: 464 kB / 0.6042 GB
Notification: Performance of [SIM] Events: time 4.979e-05/0.02583, allocations: 55.95 kB / 0.6465 GB, free: 408 kB / 0.6042 GB
Notification: Performance of [SIM] Partitioning: time 0.0005663/0.02639, allocations: 0.7371 MB / 0.6472 GB, free: 15.62 MB / 0.6198 GB
Notification: Performance of [SIM] Causalize: time 0.003861/0.03026, allocations: 4.255 MB / 0.6514 GB, free: 11.28 MB / 0.6198 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0008566/0.03111, allocations: 1.421 MB / 0.6527 GB, free: 9.855 MB / 0.6198 GB
Notification: Performance of [INI] Simplify: time 0.0008818/0.03199, allocations: 0.6725 MB / 0.6534 GB, free: 9.125 MB / 0.6198 GB
Notification: Performance of [INI] Inline: time 0.001611/0.0336, allocations: 2.622 MB / 0.656 GB, free: 6.496 MB / 0.6198 GB
Notification: Performance of [INI] Partitioning: time 6.43e-05/0.03367, allocations: 48.02 kB / 0.656 GB, free: 6.438 MB / 0.6198 GB
Notification: Performance of [INI] Cleanup: time 0.0002827/0.03395, allocations: 451.6 kB / 0.6564 GB, free: 5.996 MB / 0.6198 GB
Notification: Performance of [INI] Causalize: time 0.002381/0.03633, allocations: 2.842 MB / 0.6592 GB, free: 3.109 MB / 0.6198 GB
Notification: Performance of [INI] Tearing: time 0.0001749/0.03651, allocations: 187.7 kB / 0.6594 GB, free: 2.926 MB / 0.6198 GB
Notification: Performance of [SIM] Initialization: time 1.202e-06/0.03651, allocations: 0 / 0.6594 GB, free: 2.926 MB / 0.6198 GB
Notification: Performance of [SIM] DAE-Mode: time 0.0004518/0.03696, allocations: 368.8 kB / 0.6597 GB, free: 2.559 MB / 0.6198 GB
Notification: Performance of [SIM] Remove Dummies: time 5.861e-06/0.03697, allocations: 4.656 kB / 0.6597 GB, free: 2.555 MB / 0.6198 GB
Notification: Performance of [SIM] Tearing: time 0.0001308/0.0371, allocations: 231.8 kB / 0.66 GB, free: 2.328 MB / 0.6198 GB
Notification: Performance of [SIM] Categorize: time 1.629e-05/0.03711, allocations: 11.98 kB / 0.66 GB, free: 2.316 MB / 0.6198 GB
Notification: Performance of [SIM] Solve: time 0.001281/0.03839, allocations: 1.273 MB / 0.6612 GB, free: 1.035 MB / 0.6198 GB
Notification: Performance of [SIM] Jacobian: time 0.001889/0.04028, allocations: 2.843 MB / 0.664 GB, free: 14.02 MB / 0.6355 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 7.61e-07/0.04028, allocations: 0 / 0.664 GB, free: 14.02 MB / 0.6355 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 1
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 0
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 0 (0) {}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 0 (0) {}
 * Number of clocks: ............................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 77 (scalar:77, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 4 (linear: 4, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 101 (scalar:101, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 4 (linear: 4, nonlinear:0)
Notification: Performance of backend: time 5.664e-05/0.04034, allocations: 44.11 kB / 0.664 GB, free: 13.98 MB / 0.6355 GB
Error: Internal error NSimStrongComponent.Block.createEquation failed with status Solve.EXPLICIT for
[FOR-] (2) ($RES_SIM_101)
[----] for $i1 in 1:2 loop
[----]   [SCAL] (1) $RES_SIM_101[$i1] = -(Lline_2b.terminal_p.i[$i1] + R2.i[$i1]) ($RES_SIM_102)
[----] end for;
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 2.53659135568887]
Failed to read output from testmodel.py, exit status != 0:
0.04728647507727146 0.286428297 0.036416692
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7cac879c5550>