Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Storage.Examples.StratifiedEnhancedInternalHex.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.00103/0.00103, allocations: 80.25 kB / 20.06 MB, free: 4.457 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.001155/0.001155, allocations: 173.9 kB / 23.35 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.9439/0.9439, allocations: 177.1 MB / 203.7 MB, free: 5.734 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.7196/0.7196, allocations: 154.6 MB / 414.7 MB, free: 0.7852 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.Fluid.Storage.Examples.StratifiedEnhancedInternalHex,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Storage.Examples.StratifiedEnhancedInternalHex")
translateModel(IDEAS.Fluid.Storage.Examples.StratifiedEnhancedInternalHex,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Storage.Examples.StratifiedEnhancedInternalHex") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.371e-05/2.371e-05, allocations: 8.203 kB / 0.6195 GB, free: 13.11 MB / 0.5886 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Storage.Examples.StratifiedEnhancedInternalHex): time 0.4979/0.498, allocations: 138.5 MB / 0.7548 GB, free: 17.29 MB / 0.6355 GB
Notification: Performance of NFInst.instExpressions: time 0.04612/0.5441, allocations: 41.67 MB / 0.7955 GB, free: 4.965 MB / 0.6511 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.009966/0.554, allocations: 284.8 kB / 0.7957 GB, free: 4.816 MB / 0.6511 GB
Notification: Performance of NFTyping.typeComponents: time 0.007893/0.5619, allocations: 2.498 MB / 0.7982 GB, free: 3.309 MB / 0.6511 GB
Notification: Performance of NFTyping.typeBindings: time 0.01869/0.5806, allocations: 6.407 MB / 0.8044 GB, free: 15.35 MB / 0.6667 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01251/0.5931, allocations: 5.12 MB / 0.8094 GB, free: 11.45 MB / 0.6667 GB
Notification: Performance of NFFlatten.flatten: time 0.0316/0.6247, allocations: 34.92 MB / 0.8436 GB, free: 15.79 MB / 0.698 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02054/0.6453, allocations: 12.22 MB / 0.8555 GB, free: 3.41 MB / 0.698 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03144/0.6767, allocations: 13.67 MB / 0.8688 GB, free: 5.734 MB / 0.7136 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01493/0.6916, allocations: 7.869 MB / 0.8765 GB, free: 13.85 MB / 0.7292 GB
Notification: Performance of NFPackage.collectConstants: time 0.005038/0.6967, allocations: 1.176 MB / 0.8777 GB, free: 12.68 MB / 0.7292 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01175/0.7084, allocations: 3.384 MB / 0.881 GB, free: 9.285 MB / 0.7292 GB
Notification: Performance of combineBinaries: time 0.02128/0.7297, allocations: 16.04 MB / 0.8966 GB, free: 9.148 MB / 0.7448 GB
Notification: Performance of replaceArrayConstructors: time 0.01016/0.7399, allocations: 8.663 MB / 0.9051 GB, free: 432 kB / 0.7448 GB
Notification: Performance of NFVerifyModel.verify: time 0.00394/0.7438, allocations: 0.6602 MB / 0.9057 GB, free: 15.76 MB / 0.7605 GB
Notification: Performance of FrontEnd: time 0.001393/0.7452, allocations: 171.2 kB / 0.9059 GB, free: 15.59 MB / 0.7605 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3221 (1730)
 * Number of variables: 3221 (884)
Notification: Performance of [SIM] Bindings: time 0.06991/0.8151, allocations: 48.35 MB / 0.9531 GB, free: 14.6 MB / 0.8073 GB
Notification: Performance of [SIM] FunctionAlias: time 0.02414/0.8392, allocations: 9.703 MB / 0.9626 GB, free: 5.164 MB / 0.8073 GB
Notification: Performance of [SIM] Early Inline: time 0.05568/0.8949, allocations: 34.98 MB / 0.9968 GB, free: 2.148 MB / 0.8386 GB
Notification: Performance of [SIM] Simplify 1: time 0.5048/1.4, allocations: 3.728 MB / 1 GB, free: 111.3 MB / 0.8386 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.05837/1.458, allocations: 25.02 MB / 1.025 GB, free: 107.8 MB / 0.8386 GB
Notification: Performance of [SIM] Simplify 2: time 0.01066/1.469, allocations: 3.45 MB / 1.028 GB, free: 107.4 MB / 0.8386 GB
Notification: Performance of [SIM] Remove Stream: time 0.01113/1.48, allocations: 2.872 MB / 1.031 GB, free: 107 MB / 0.8386 GB
Notification: Performance of [SIM] Detect States: time 0.02936/1.509, allocations: 8.895 MB / 1.04 GB, free: 106.4 MB / 0.8386 GB
Notification: Performance of [SIM] Events: time 0.002332/1.512, allocations: 0.7026 MB / 1.04 GB, free: 106.3 MB / 0.8386 GB
Notification: Performance of [SIM] Partitioning: time 0.03693/1.549, allocations: 12.35 MB / 1.052 GB, free: 104.7 MB / 0.8386 GB
Notification: Performance of [SIM] Causalize: time 0.1185/1.667, allocations: 72.68 MB / 1.123 GB, free: 83.61 MB / 0.8386 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.03931/1.706, allocations: 26.21 MB / 1.149 GB, free: 61.78 MB / 0.8386 GB
Notification: Performance of [INI] Simplify: time 0.0267/1.733, allocations: 13.37 MB / 1.162 GB, free: 51.46 MB / 0.8386 GB
Notification: Performance of [INI] Inline: time 0.0652/1.798, allocations: 49.05 MB / 1.21 GB, free: 4.223 MB / 0.8386 GB
Notification: Performance of [INI] Partitioning: time 0.003993/1.802, allocations: 0.5603 MB / 1.211 GB, free: 3.594 MB / 0.8386 GB
Notification: Performance of [INI] Cleanup: time 0.02909/1.831, allocations: 13.62 MB / 1.224 GB, free: 6.082 MB / 0.8542 GB
Notification: Performance of [INI] Causalize: time 0.8157/2.647, allocations: 174.2 MB / 1.394 GB, free: 169.8 MB / 0.9792 GB
Notification: Performance of [INI] Tearing: time 0.008334/2.655, allocations: 8.784 MB / 1.402 GB, free: 169.7 MB / 0.9792 GB
Notification: Performance of [SIM] Initialization: time 2.445e-06/2.655, allocations: 0 / 1.402 GB, free: 169.7 MB / 0.9792 GB
Notification: Performance of [SIM] DAE-Mode: time 0.00666/2.662, allocations: 2.485 MB / 1.405 GB, free: 168.8 MB / 0.9792 GB
Notification: Performance of [SIM] Remove Dummies: time 5.155e-05/2.662, allocations: 20.2 kB / 1.405 GB, free: 168.8 MB / 0.9792 GB
Notification: Performance of [SIM] Tearing: time 0.006921/2.669, allocations: 6.599 MB / 1.411 GB, free: 168.7 MB / 0.9792 GB
Notification: Performance of [SIM] Categorize: time 0.0001228/2.669, allocations: 40 kB / 1.411 GB, free: 168.7 MB / 0.9792 GB
Notification: Performance of [SIM] Solve: time 0.05468/2.724, allocations: 13.62 MB / 1.425 GB, free: 168 MB / 0.9792 GB
Notification: Performance of [SIM] Jacobian: time 0.1336/2.857, allocations: 146.8 MB / 1.568 GB, free: 108.5 MB / 0.9792 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 8.585e-05/2.857, allocations: 3.672 kB / 1.568 GB, free: 108.5 MB / 0.9792 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 38
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 0
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 1
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 30 (6) {tanSte.vol.dynBal.U, tanDyn.vol.dynBal.U, tanDyn.indTanHex.vol.dynBal.U, tanDyn.indTanHex.cap.T, tanDynSol.vol.dynBal.U, tanDynSol.indTanHex.cap.T}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 1 (1) {$TEV_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: ........... 899 (scalar:881, array:18, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 310 (resizable: 310, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 30 (linear: 27, nonlinear:3)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 1064 (scalar:1039, array:25, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 626 (resizable: 626, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 30 (linear: 30, nonlinear:0)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 1070 (scalar:1045, array:25, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 626 (resizable: 626, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 27 (linear: 27, nonlinear:0)
Notification: Performance of backend: time 0.000701/2.858, allocations: 0.6168 MB / 1.569 GB, free: 107.9 MB / 0.9792 GB
Error: Internal error NSimStrongComponent.Block.createEquation failed with status Solve.EXPLICIT for
[FOR-] (4) ($RES_SIM_892)
[----] for $i1 in 1:4 loop
[----]   [SCAL] (1) $RES_SIM_892[$i1] = tanSte.conWal[$i1].G * tanSte.conWal[$i1].dT - tanSte.conWal[$i1].Q_flow ($RES_SIM_893)
[----] end for;
"
[Timeout remaining time 657]
[Calling sys.exit(0), Time elapsed: 5.669409313239157]
Failed to read output from testmodel.py, exit status != 0:
2.9373303279280663 2.946447989 2.199196317
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f2eda7c4350>