Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Electrical.AC.ThreePhasesBalanced.Lines.Examples.ACLineMedium.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.001114/0.001114, allocations: 80.25 kB / 20.05 MB, free: 4.465 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.001386/0.001386, allocations: 173.9 kB / 23.36 MB, free: 1.156 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.8612/0.8612, allocations: 177.1 MB / 203.7 MB, free: 5.699 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.6658/0.6658, allocations: 154.6 MB / 414.7 MB, free: 0.7812 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.ThreePhasesBalanced.Lines.Examples.ACLineMedium,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Electrical.AC.ThreePhasesBalanced.Lines.Examples.ACLineMedium")
translateModel(IDEAS.Electrical.AC.ThreePhasesBalanced.Lines.Examples.ACLineMedium,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Electrical.AC.ThreePhasesBalanced.Lines.Examples.ACLineMedium") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.784e-05/1.784e-05, allocations: 5.594 kB / 0.6195 GB, free: 12.01 MB / 0.5417 GB
Notification: Performance of NFInst.instantiate(IDEAS.Electrical.AC.ThreePhasesBalanced.Lines.Examples.ACLineMedium): time 0.0108/0.01082, allocations: 13.71 MB / 0.6329 GB, free: 14.24 MB / 0.5573 GB
Notification: Performance of NFInst.instExpressions: time 0.009934/0.02075, allocations: 9.826 MB / 0.6425 GB, free: 4.387 MB / 0.5573 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001084/0.02184, allocations: 75.31 kB / 0.6426 GB, free: 4.312 MB / 0.5573 GB
Notification: Performance of NFTyping.typeComponents: time 0.002438/0.02428, allocations: 1.695 MB / 0.6442 GB, free: 2.609 MB / 0.5573 GB
Notification: Performance of NFTyping.typeBindings: time 0.004046/0.02832, allocations: 1.899 MB / 0.6461 GB, free: 0.707 MB / 0.5573 GB
Notification: Performance of NFTyping.typeClassSections: time 0.303/0.3313, allocations: 0.7673 MB / 0.6468 GB, free: 19.16 MB / 0.5573 GB
Notification: Performance of NFFlatten.flatten: time 0.004412/0.3357, allocations: 3.281 MB / 0.65 GB, free: 18.76 MB / 0.5573 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001727/0.3374, allocations: 1.003 MB / 0.651 GB, free: 18.61 MB / 0.5573 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003441/0.3409, allocations: 2.492 MB / 0.6535 GB, free: 18.46 MB / 0.5573 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001439/0.3423, allocations: 0.8217 MB / 0.6543 GB, free: 18.37 MB / 0.5573 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001835/0.3425, allocations: 134.8 kB / 0.6544 GB, free: 18.37 MB / 0.5573 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001286/0.3438, allocations: 0.6617 MB / 0.655 GB, free: 18.34 MB / 0.5573 GB
Notification: Performance of combineBinaries: time 0.002309/0.3461, allocations: 3.103 MB / 0.6581 GB, free: 17.16 MB / 0.5573 GB
Notification: Performance of replaceArrayConstructors: time 0.001797/0.3479, allocations: 1.965 MB / 0.66 GB, free: 16.16 MB / 0.5573 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004397/0.3483, allocations: 146.6 kB / 0.6601 GB, free: 16.16 MB / 0.5573 GB
Notification: Performance of FrontEnd: time 0.0002248/0.3485, allocations: 45.33 kB / 0.6602 GB, free: 16.15 MB / 0.5573 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 327 (253)
 * Number of variables: 327 (244)
Notification: Performance of [SIM] Bindings: time 0.005215/0.3538, allocations: 8.072 MB / 0.6681 GB, free: 12.25 MB / 0.5573 GB
Notification: Performance of [SIM] FunctionAlias: time 0.00123/0.355, allocations: 1.523 MB / 0.6695 GB, free: 11.46 MB / 0.5573 GB
Notification: Performance of [SIM] Early Inline: time 0.004561/0.3596, allocations: 6.606 MB / 0.676 GB, free: 8.125 MB / 0.5573 GB
Notification: Performance of [SIM] Simplify 1: time 0.0007132/0.3603, allocations: 0.7002 MB / 0.6767 GB, free: 7.891 MB / 0.5573 GB
Notification: Performance of [SIM] Alias: time 0.005313/0.3656, allocations: 7.115 MB / 0.6836 GB, free: 4.055 MB / 0.5573 GB
Notification: Performance of [SIM] Simplify 2: time 0.0005064/0.3661, allocations: 0.5663 MB / 0.6842 GB, free: 3.879 MB / 0.5573 GB
Notification: Performance of [SIM] Remove Stream: time 0.0002766/0.3664, allocations: 398.5 kB / 0.6846 GB, free: 3.641 MB / 0.5573 GB
Notification: Performance of [SIM] Detect States: time 0.0009431/0.3673, allocations: 1.413 MB / 0.6859 GB, free: 2.855 MB / 0.5573 GB
Notification: Performance of [SIM] Events: time 0.0001251/0.3674, allocations: 180.2 kB / 0.6861 GB, free: 2.773 MB / 0.5573 GB
Notification: Performance of [SIM] Partitioning: time 0.001407/0.3688, allocations: 1.865 MB / 0.6879 GB, free: 1.926 MB / 0.5573 GB
Notification: Performance of [SIM] Causalize: time 0.007324/0.3762, allocations: 9.288 MB / 0.697 GB, free: 14.65 MB / 0.573 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.002095/0.3783, allocations: 3.658 MB / 0.7006 GB, free: 11.04 MB / 0.573 GB
Notification: Performance of [INI] Simplify: time 0.002301/0.3806, allocations: 2.478 MB / 0.703 GB, free: 8.496 MB / 0.573 GB
Notification: Performance of [INI] Inline: time 0.004155/0.3847, allocations: 7.25 MB / 0.7101 GB, free: 1.348 MB / 0.573 GB
Notification: Performance of [INI] Partitioning: time 0.0001702/0.3849, allocations: 115.1 kB / 0.7102 GB, free: 1.207 MB / 0.573 GB
Notification: Performance of [INI] Cleanup: time 0.000981/0.3859, allocations: 1.258 MB / 0.7114 GB, free: 0 / 0.573 GB
Notification: Performance of [INI] Causalize: time 0.006905/0.3928, allocations: 8.093 MB / 0.7193 GB, free: 7.859 MB / 0.5886 GB
Notification: Performance of [INI] Tearing: time 0.0003156/0.3931, allocations: 496.9 kB / 0.7198 GB, free: 7.395 MB / 0.5886 GB
Notification: Performance of [SIM] Initialization: time 1.282e-06/0.3931, allocations: 4 kB / 0.7198 GB, free: 7.391 MB / 0.5886 GB
Notification: Performance of [SIM] DAE-Mode: time 0.001091/0.3942, allocations: 1.102 MB / 0.7209 GB, free: 6.32 MB / 0.5886 GB
Notification: Performance of [SIM] Remove Dummies: time 5.991e-06/0.3942, allocations: 1.312 kB / 0.7209 GB, free: 6.32 MB / 0.5886 GB
Notification: Performance of [SIM] Tearing: time 0.0002747/0.3945, allocations: 0.5114 MB / 0.7214 GB, free: 5.832 MB / 0.5886 GB
Notification: Performance of [SIM] Categorize: time 1.121e-05/0.3945, allocations: 4 kB / 0.7214 GB, free: 5.828 MB / 0.5886 GB
Notification: Performance of [SIM] Solve: time 0.003266/0.3977, allocations: 4.466 MB / 0.7257 GB, free: 1.43 MB / 0.5886 GB
Notification: Performance of [SIM] Jacobian: time 0.004336/0.4021, allocations: 6.016 MB / 0.7316 GB, free: 11.38 MB / 0.6042 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 1.202e-06/0.4021, allocations: 0 / 0.7316 GB, free: 11.38 MB / 0.6042 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: ........... 126 (scalar:120, array:6, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 5 (resizable: 5, 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: ........... 276 (scalar:264, array:12, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 5 (resizable: 5, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 4 (linear: 4, nonlinear:0)
Notification: Performance of backend: time 7.112e-05/0.4021, allocations: 75 kB / 0.7317 GB, free: 11.31 MB / 0.6042 GB
Error: Internal error NSimStrongComponent.Block.createEquation failed with status Solve.EXPLICIT for
[FOR-] (2) ($RES_SIM_147)
[----] for $i1 in 1:2 loop
[----]   [SCAL] (1) $RES_SIM_147[$i1] = -(line_sc.terminal_p.i[$i1] + load_sc.i[$i1]) ($RES_SIM_148)
[----] end for;
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 2.773756575770676]
Failed to read output from testmodel.py, exit status != 0:
0.41019508242607117 0.41724361600000004 0.06698533100000001
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x784fa1dc8230>