Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0_Modelica.StateGraph.Examples.ExecutionPaths.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.001371/0.001371, allocations: 99.59 kB / 21.2 MB, free: 0.6406 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.001858/0.001858, allocations: 221.1 kB / 24.5 MB, free: 3.922 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.479/1.479, allocations: 230.6 MB / 258.3 MB, free: 7.785 MB / 206.1 MB
"
[Timeout remaining time 178]
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(Modelica.StateGraph.Examples.ExecutionPaths,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5028,variableFilter="time|transition1.enableFire|transition2.enableFire|transition3.enableFire|transition4.enableFire|transition4a.enableFire|transition5.enableFire|transition6.enableFire|transition6a.enableFire|transition7.enableFire",fileNamePrefix="Modelica_4.1.0_Modelica.StateGraph.Examples.ExecutionPaths")
translateModel(Modelica.StateGraph.Examples.ExecutionPaths,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5028,variableFilter="time|transition1.enableFire|transition2.enableFire|transition3.enableFire|transition4.enableFire|transition4a.enableFire|transition5.enableFire|transition6.enableFire|transition6a.enableFire|transition7.enableFire",fileNamePrefix="Modelica_4.1.0_Modelica.StateGraph.Examples.ExecutionPaths") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.216e-05/2.216e-05, allocations: 2.281 kB / 378.9 MB, free: 2.543 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(Modelica.StateGraph.Examples.ExecutionPaths): time 0.003695/0.003717, allocations: 2.422 MB / 381.3 MB, free: 112 kB / 302.1 MB
Notification: Performance of NFInst.instExpressions: time 0.1965/0.2002, allocations: 0.9103 MB / 382.2 MB, free: 13.02 MB / 302.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002321/0.2004, allocations: 24.44 kB / 382.3 MB, free: 13.02 MB / 302.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0002749/0.2007, allocations: 108 kB / 382.4 MB, free: 13.01 MB / 302.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0001593/0.2009, allocations: 77.38 kB / 382.5 MB, free: 12.96 MB / 302.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0009956/0.2019, allocations: 0.4888 MB / 382.9 MB, free: 12.95 MB / 302.1 MB
Notification: Performance of NFFlatten.flatten: time 0.001301/0.2032, allocations: 1.291 MB / 384.2 MB, free: 12.7 MB / 302.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009506/0.2041, allocations: 0.6721 MB / 384.9 MB, free: 12.41 MB / 302.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0005142/0.2046, allocations: 0.5055 MB / 385.4 MB, free: 12.18 MB / 302.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0005065/0.2051, allocations: 486.4 kB / 385.9 MB, free: 11.93 MB / 302.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.000177/0.2053, allocations: 109 kB / 386 MB, free: 11.93 MB / 302.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0002003/0.2055, allocations: 124.2 kB / 386.1 MB, free: 11.92 MB / 302.1 MB
Notification: Performance of combineBinaries: time 0.0008563/0.2064, allocations: 1.601 MB / 387.7 MB, free: 10.82 MB / 302.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0003955/0.2068, allocations: 0.9371 MB / 388.6 MB, free: 10.18 MB / 302.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001112/0.2069, allocations: 59.09 kB / 388.7 MB, free: 10.17 MB / 302.1 MB
Notification: Performance of FrontEnd: time 0.0001859/0.2071, allocations: 163.3 kB / 388.9 MB, free: 10.12 MB / 302.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 243 (237)
 * Number of variables: 243 (231)
Notification: Performance of [SIM] Bindings: time 0.003382/0.2105, allocations: 3.609 MB / 392.5 MB, free: 7.832 MB / 302.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0009154/0.2114, allocations: 0.7044 MB / 393.2 MB, free: 7.398 MB / 302.1 MB
Notification: Performance of [SIM] Early Inline: time 0.002715/0.2141, allocations: 2.773 MB / 396 MB, free: 5.789 MB / 302.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0008579/0.2149, allocations: 0.5125 MB / 396.5 MB, free: 5.457 MB / 302.1 MB
Notification: Performance of [SIM] Alias: time 0.004778/0.2197, allocations: 3.843 MB / 400.3 MB, free: 3.094 MB / 302.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0004955/0.2202, allocations: 395 kB / 400.7 MB, free: 2.773 MB / 302.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0002649/0.2205, allocations: 254.8 kB / 400.9 MB, free: 2.551 MB / 302.1 MB
Notification: Performance of [SIM] Detect States: time 0.0008354/0.2213, allocations: 0.798 MB / 401.7 MB, free: 1.902 MB / 302.1 MB
Notification: Performance of [SIM] Events: time 0.000394/0.2217, allocations: 301.9 kB / 402 MB, free: 1.68 MB / 302.1 MB
Notification: Performance of [SIM] Partitioning: time 0.001053/0.2228, allocations: 0.974 MB / 403 MB, free: 1.102 MB / 302.1 MB
Notification: Performance of [SIM] Causalize: time 0.003727/0.2265, allocations: 2.86 MB / 405.9 MB, free: 76 kB / 302.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.001998/0.2285, allocations: 1.964 MB / 407.8 MB, free: 14.6 MB / 318.1 MB
Notification: Performance of [INI] Simplify: time 0.001673/0.2302, allocations: 0.8941 MB / 408.7 MB, free: 13.94 MB / 318.1 MB
Notification: Performance of [INI] Inline: time 0.002762/0.2329, allocations: 2.617 MB / 411.3 MB, free: 11.76 MB / 318.1 MB
Notification: Performance of [INI] Partitioning: time 0.000171/0.2331, allocations: 76.05 kB / 411.4 MB, free: 11.67 MB / 318.1 MB
Notification: Performance of [INI] Cleanup: time 0.0003927/0.2335, allocations: 439.6 kB / 411.8 MB, free: 11.24 MB / 318.1 MB
Notification: Performance of [INI] Causalize: time 0.008604/0.2421, allocations: 5.982 MB / 417.8 MB, free: 5.125 MB / 318.1 MB
Notification: Performance of [INI] Tearing: time 0.0008294/0.2429, allocations: 0.5922 MB / 418.4 MB, free: 4.504 MB / 318.1 MB
Notification: Performance of [SIM] Initialization: time 1.332e-06/0.2429, allocations: 0 / 418.4 MB, free: 4.504 MB / 318.1 MB
Notification: Performance of [SIM] Remove Dummies: time 2.823e-05/0.243, allocations: 6 kB / 418.4 MB, free: 4.496 MB / 318.1 MB
Notification: Performance of [SIM] Tearing: time 0.0009513/0.2439, allocations: 0.5913 MB / 419 MB, free: 3.895 MB / 318.1 MB
Notification: Performance of [SIM] Categorize: time 2.383e-05/0.2439, allocations: 8 kB / 419 MB, free: 3.887 MB / 318.1 MB
Error: Internal error NFExpression.makeOne failed for: Boolean
Error: Internal error NBSolve.solveStrongComponent failed with status = Solve.UNSOLVABLE while trying to solve following strong component:
BLOCK: Resizable Component (status = Solve.UNPROCESSED, size = 3)
-------------------------------------------------------------------
### Variable:
	$SEV_26[$i1]
### Equation:
	[FOR-] (3) ($RES_SIM_53)
[----] for $i1 in 1:3 loop
[----]   [SCAL] (1) alternative.split[$i1].available = if $SEV_25[$i1] then alternative.inPort.available else $SEV_26[$i1] ($RES_SIM_54)
[----] end for;
Error: Internal error NBSolve.solveStrongComponent failed with status = Solve.UNSOLVABLE while trying to solve following strong component:
BLOCK: Algebraic Loop (Linear = false, Mixed = true, Homotopy = false, size = 15)
-----------------------------------------------------------------------------------
Strict Tearing Set
********************
### Iteration Variables:
	[DISC] (1) Boolean transition3.inPort.available;
	[DISC] (1) Boolean transition4.inPort.available;
### Residual Equations:

### Inner Equations:
	BLOCK: Single Strong Component (status = Solve.UNPROCESSED, size = 1)
-----------------------------------------------------------------------
### Variable:
	Boolean $SEV_9
### Equation:
	[SCAL] (1) $SEV_9 = transition3.inPort.available and not transition3.outPort.occupied ($RES_EVT_341)

	BLOCK: Single Strong Component (status = Solve.UNPROCESSED, size = 1)
-----------------------------------------------------------------------
### Variable:
	Boolean transition3.enableFire
### Equation:
	[SCAL] (1) transition3.enableFire = $SEV_9 ($RES_SIM_127)

	BLOCK: Single Strong Component (status = Solve.UNPROCESSED, size = 1)
-----------------------------------------------------------------------
### Variable:
	Boolean $SEV_8
### Equation:
	[SCAL] (1) $SEV_8 = transition3.enableFire and time >= (transition3.t_start + transition3.waitTime) ($RES_EVT_340)

	BLOCK: Single Strong Component (status = Solve.UNPROCESSED, size = 1)
-----------------------------------------------------------------------
### Variable:
	Boolean transition3.fire
### Equation:
	[SCAL] (1) transition3.fire = $SEV_8 ($RES_SIM_128)

	BLOCK: Single Strong Component (status = Solve.UNPROCESSED, size = 1)
-----------------------------------------------------------------------
### Variable:
	Boolean $SEV_11
### Equation:
	[SCAL] (1) $SEV_11 = transition4.inPort.available and not transition4.outPort.occupied ($RES_EVT_343)

	BLOCK: Single Strong Component (status = Solve.UNPROCESSED, size = 1)
-----------------------------------------------------------------------
### Variable:
	Boolean transition4.enableFire
### Equation:
	[SCAL] (1) transition4.enableFire = $SEV_11 ($RES_SIM_120)

	BLOCK: Single Strong Component (status = Solve.UNPROCESSED, size = 1)
-----------------------------------------------------------------------
### Variable:
	Boolean $SEV_10
### Equation:
	[SCAL] (1) $SEV_10 = transition4.enableFire and time >= (transition4.t_start + transition4.waitTime) ($RES_EVT_342)

	BLOCK: Single Strong Component (status = Solve.UNPROCESSED, size = 1)
-----------------------------------------------------------------------
### Variable:
	Boolean transition4.fire
### Equation:
	[SCAL] (1) transition4.fire = $SEV_10 ($RES_SIM_121)

	BLOCK: Sliced Component (status = Solve.UNPROCESSED, size = 1)
----------------------------------------------------------------
### Variable:
	alternative.split[1].available
### Equation:
	[SCAL] (1) transition3.inPort.available = alternative.split[1].available ($RES_SIM_206)

	BLOCK: Sliced Component (status = Solve.UNPROCESSED, size = 1)
----------------------------------------------------------------
### Variable:
	alternative.split[2].available
### Equation:
	[SCAL] (1) transition4.inPort.available = alternative.split[2].available ($RES_SIM_204)

	BLOCK: Sliced Component (status = Solve.UNPROCESSED, size = 1)
----------------------------------------------------------------
### Variable:
	alternative.split[1].reset
### Equation:
	[SCAL] (1) transition3.fire = alternative.split[1].reset ($RES_SIM_205)

	BLOCK: Sliced Component (status = Solve.UNPROCESSED, size = 1)
----------------------------------------------------------------
### Variable:
	alternative.split[2].reset
### Equation:
	[SCAL] (1) transition4.fire = alternative.split[2].reset ($RES_SIM_203)

	BLOCK: Resizable Component (status = Solve.UNPROCESSED, size = 3)
-------------------------------------------------------------------
### Variable:
	$SEV_26[$i1]
### Equation:
	[FOR-] (3) ($RES_SIM_53)
[----] for $i1 in 1:3 loop
[----]   [SCAL] (1) alternative.split[$i1].available = if $SEV_25[$i1] then alternative.inPort.available else $SEV_26[$i1] ($RES_SIM_54)
[----] end for;
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 2.4625298120081425]
Failed to read output from testmodel.py, exit status != 0:
['time', 'transition1.enableFire', 'transition2.enableFire', 'transition3.enableFire', 'transition4.enableFire', 'transition4a.enableFire', 'transition5.enableFire', 'transition6.enableFire', 'transition6a.enableFire', 'transition7.enableFire']
0.2526584477163851 0.26676767100000004 0.056723353000000004
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f69730daf20>