Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0_Modelica.Electrical.Digital.Examples.Adder4.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.001324/0.001324, 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.001486/0.001486, 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.437/1.437, allocations: 230.6 MB / 258.3 MB, free: 7.789 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.Electrical.Digital.Examples.Adder4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5021,variableFilter="time|Adder1.Adder1.AND.G2.x|Adder1.Adder1.AND.G2.y|Adder1.Adder1.XOR.G2.x|Adder1.Adder1.XOR.G2.y|Adder1.Adder2.AND.G2.x|Adder1.Adder2.AND.G2.y|Adder1.Adder2.XOR.G2.x|Adder1.Adder2.XOR.G2.y|Adder2.Adder1.AND.G2.x|Adder2.Adder1.AND.G2.y|Adder2.Adder1.XOR.G2.x|Adder2.Adder1.XOR.G2.y|Adder2.Adder2.AND.G2.x|Adder2.Adder2.AND.G2.y|Adder2.Adder2.XOR.G2.x|Adder2.Adder2.XOR.G2.y|Adder3.Adder1.AND.G2.x|Adder3.Adder1.AND.G2.y|Adder3.Adder1.XOR.G2.x|Adder3.Adder1.XOR.G2.y|Adder3.Adder2.AND.G2.x|Adder3.Adder2.AND.G2.y|Adder3.Adder2.XOR.G2.x|Adder3.Adder2.XOR.G2.y|Adder4.Adder1.AND.G2.x|Adder4.Adder1.AND.G2.y|Adder4.Adder1.XOR.G2.x|Adder4.Adder1.XOR.G2.y|Adder4.Adder2.AND.G2.x|Adder4.Adder2.AND.G2.y|Adder4.Adder2.XOR.G2.x|Adder4.Adder2.XOR.G2.y",fileNamePrefix="Modelica_4.1.0_Modelica.Electrical.Digital.Examples.Adder4")
translateModel(Modelica.Electrical.Digital.Examples.Adder4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5021,variableFilter="time|Adder1.Adder1.AND.G2.x|Adder1.Adder1.AND.G2.y|Adder1.Adder1.XOR.G2.x|Adder1.Adder1.XOR.G2.y|Adder1.Adder2.AND.G2.x|Adder1.Adder2.AND.G2.y|Adder1.Adder2.XOR.G2.x|Adder1.Adder2.XOR.G2.y|Adder2.Adder1.AND.G2.x|Adder2.Adder1.AND.G2.y|Adder2.Adder1.XOR.G2.x|Adder2.Adder1.XOR.G2.y|Adder2.Adder2.AND.G2.x|Adder2.Adder2.AND.G2.y|Adder2.Adder2.XOR.G2.x|Adder2.Adder2.XOR.G2.y|Adder3.Adder1.AND.G2.x|Adder3.Adder1.AND.G2.y|Adder3.Adder1.XOR.G2.x|Adder3.Adder1.XOR.G2.y|Adder3.Adder2.AND.G2.x|Adder3.Adder2.AND.G2.y|Adder3.Adder2.XOR.G2.x|Adder3.Adder2.XOR.G2.y|Adder4.Adder1.AND.G2.x|Adder4.Adder1.AND.G2.y|Adder4.Adder1.XOR.G2.x|Adder4.Adder1.XOR.G2.y|Adder4.Adder2.AND.G2.x|Adder4.Adder2.AND.G2.y|Adder4.Adder2.XOR.G2.x|Adder4.Adder2.XOR.G2.y",fileNamePrefix="Modelica_4.1.0_Modelica.Electrical.Digital.Examples.Adder4") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.181e-05/2.181e-05, allocations: 2.281 kB / 378.9 MB, free: 2.492 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Electrical.Digital.Examples.Adder4): time 0.201/0.201, allocations: 5.001 MB / 383.9 MB, free: 12.04 MB / 302.1 MB
Notification: Performance of NFInst.instExpressions: time 0.005168/0.2062, allocations: 2.432 MB / 386.4 MB, free: 11 MB / 302.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000521/0.2067, allocations: 34.44 kB / 386.4 MB, free: 10.98 MB / 302.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0005291/0.2073, allocations: 243.7 kB / 386.6 MB, free: 10.82 MB / 302.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0006962/0.208, allocations: 331.3 kB / 387 MB, free: 10.59 MB / 302.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001779/0.2097, allocations: 0.891 MB / 387.9 MB, free: 9.973 MB / 302.1 MB
Notification: Performance of NFFlatten.flatten: time 0.00286/0.2126, allocations: 2.83 MB / 390.7 MB, free: 8.449 MB / 302.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009705/0.2136, allocations: 0.4944 MB / 391.2 MB, free: 8.113 MB / 302.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005039/0.2186, allocations: 3.181 MB / 394.4 MB, free: 7.332 MB / 302.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002305/0.2209, allocations: 1.398 MB / 395.8 MB, free: 6.742 MB / 302.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0007133/0.2216, allocations: 292.4 kB / 396 MB, free: 6.742 MB / 302.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0006683/0.2223, allocations: 302.7 kB / 396.3 MB, free: 6.742 MB / 302.1 MB
Notification: Performance of combineBinaries: time 0.003721/0.226, allocations: 3.747 MB / 400.1 MB, free: 4.203 MB / 302.1 MB
Notification: Performance of replaceArrayConstructors: time 0.001282/0.2273, allocations: 1.806 MB / 401.9 MB, free: 2.922 MB / 302.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0005471/0.2278, allocations: 141.2 kB / 402 MB, free: 2.922 MB / 302.1 MB
Notification: Performance of FrontEnd: time 0.0002876/0.2281, allocations: 60.97 kB / 402.1 MB, free: 2.891 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: 341 (245)
 * Number of variables: 341 (285)
Notification: Performance of [SIM] Bindings: time 0.009035/0.2372, allocations: 8.5 MB / 410.6 MB, free: 13.13 MB / 318.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.00185/0.239, allocations: 1.144 MB / 411.7 MB, free: 12.11 MB / 318.1 MB
Notification: Performance of [SIM] Early Inline: time 0.009573/0.2486, allocations: 7.142 MB / 418.9 MB, free: 4.922 MB / 318.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.002619/0.2512, allocations: 1.37 MB / 420.3 MB, free: 3.461 MB / 318.1 MB
Notification: Performance of [SIM] Alias: time 0.0118/0.263, allocations: 7.446 MB / 427.7 MB, free: 11.46 MB / 334.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.001979/0.265, allocations: 1.274 MB / 429 MB, free: 10.11 MB / 334.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.00147/0.2665, allocations: 1.186 MB / 430.2 MB, free: 8.879 MB / 334.1 MB
Notification: Performance of [SIM] Detect States: time 0.003362/0.2698, allocations: 2.408 MB / 432.6 MB, free: 6.402 MB / 334.1 MB
Notification: Performance of [SIM] Events: time 0.002847/0.2727, allocations: 1.954 MB / 434.5 MB, free: 4.488 MB / 334.1 MB
Notification: Performance of [SIM] Partitioning: time 0.005677/0.2783, allocations: 4.221 MB / 438.7 MB, free: 236 kB / 334.1 MB
Notification: Performance of [SIM] Causalize: time 0.007439/0.2858, allocations: 5.219 MB / 444 MB, free: 10.96 MB / 350.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.009317/0.2951, allocations: 7.419 MB / 451.4 MB, free: 3.535 MB / 350.1 MB
Notification: Performance of [INI] Simplify: time 0.007858/0.303, allocations: 4.178 MB / 455.6 MB, free: 15.12 MB / 366.1 MB
Notification: Performance of [INI] Inline: time 0.01608/0.319, allocations: 11.49 MB / 467 MB, free: 3.605 MB / 366.1 MB
Notification: Performance of [INI] Partitioning: time 0.0005402/0.3196, allocations: 116.1 kB / 467.2 MB, free: 3.469 MB / 366.1 MB
Notification: Performance of [INI] Cleanup: time 0.00795/0.3275, allocations: 4.439 MB / 471.6 MB, free: 15.02 MB / 382.1 MB
Notification: Performance of [INI] Causalize: time 0.02437/0.3519, allocations: 16.28 MB / 487.9 MB, free: 14.46 MB / 398.1 MB
Notification: Performance of [INI] Tearing: time 0.0001242/0.352, allocations: 152 kB / 488 MB, free: 14.32 MB / 398.1 MB
Notification: Performance of [SIM] Initialization: time 2.074e-06/0.352, allocations: 0 / 488 MB, free: 14.32 MB / 398.1 MB
Notification: Performance of [SIM] Remove Dummies: time 3.278e-05/0.3521, allocations: 2 kB / 488 MB, free: 14.32 MB / 398.1 MB
Notification: Performance of [SIM] Tearing: time 5.66e-05/0.3521, allocations: 88 kB / 488.1 MB, free: 14.23 MB / 398.1 MB
Notification: Performance of [SIM] Categorize: time 6.051e-05/0.3522, allocations: 16 kB / 488.1 MB, free: 14.21 MB / 398.1 MB
Error: Internal error NFExpression.makeZero failed for: enumeration Modelica.Electrical.Digital.Interfaces.Logic('U', 'X', '0', '1', 'Z', 'W', 'L', 'H', '-')
Error: Internal error NBSolve.solveStrongComponent failed with status = Solve.UNSOLVABLE while trying to solve following strong component:
BLOCK: Multi Strong Component (status = Solve.UNPROCESSED, size = 15)
-----------------------------------------------------------------------
### Variables:
	[DISC] (1) enumeration Modelica.Electrical.Digital.Interfaces.Logic('U', 'X', '0', '1', 'Z', 'W', 'L', 'H', '-') Adder1.Adder2.AND.G2.y (fixed = true, start = Modelica.Electrical.Digital.Interfaces.Logic.'U')
	[PRE-] (1) enumeration Modelica.Electrical.Digital.Interfaces.Logic('U', 'X', '0', '1', 'Z', 'W', 'L', 'H', '-') $PRE.Adder1.Adder2.AND.G2.y
	[DISC] (1) Boolean $SEV_11
	[DISC] (1) Boolean $SEV_10
	[DISC] (1) protected enumeration Modelica.Electrical.Digital.Interfaces.Logic('U', 'X', '0', '1', 'Z', 'W', 'L', 'H', '-') Adder1.Adder2.AND.G2.y_auxiliary (fixed = true, start = Adder1.Adder2.AND.G2.y0)
	[DISC] (1) protected discrete Real Adder1.Adder2.AND.G2.t_next
	[DISC] (1) protected Integer Adder1.Adder2.AND.G2.lh
	[DISC] (1) protected Real Adder1.Adder2.AND.G2.delayTime
	[DISC] (1) protected enumeration Modelica.Electrical.Digital.Interfaces.Logic('U', 'X', '0', '1', 'Z', 'W', 'L', 'H', '-') Adder1.Adder2.AND.G2.y_old (fixed = true, start = Adder1.Adder2.AND.G2.y0)
	[DISC] (1) enumeration Modelica.Electrical.Digital.Interfaces.Logic('U', 'X', '0', '1', 'Z', 'W', 'L', 'H', '-') $TEV_20
	[DISC] (1) Boolean $SEV_9
	[DISC] (1) Boolean $SEV_14
	[DISC] (1) Boolean $SEV_8
	[DISC] (1) Boolean $SEV_13
	[DISC] (1) Boolean $SEV_12
### Equation:
	[ALGO] (15) ($RES_SIM_15)
	[----] $SEV_13 := time >= Adder1.Adder2.AND.G2.t_next;
	[----] $SEV_12 := Adder1.Adder2.AND.G2.lh == 0 or abs(Adder1.Adder2.AND.G2.delayTime) < 2.2250738585072014e-308;
	[----] $SEV_11 := Adder1.Adder2.AND.G2.lh < 0;
	[----] $SEV_10 := Adder1.Adder2.AND.G2.lh > 0;
	[----] $TEV_20 := $PRE.Adder1.Adder2.AND.G2.y;
	[----] $SEV_9 := true;
	[----] Adder1.Adder2.AND.G2.y_old := if $SEV_9 then Adder1.Adder2.AND.G2.y0 else $TEV_20;
	[----] Adder1.Adder2.AND.G2.lh := ({{0, 0, -1, 1, 0, 0, -1, 1, 0}, {0, 0, -1, 1, 0, 0, -1, 1, 0}, {1, 1, 0, 1, 1, 1, 0, 1, 1}, {-1, -1, -1, 0, -1, -1, -1, 0, -1}, {0, 0, -1, 1, 0, 0, -1, 1, 0}, {0, 0, -1, 1, 0, 0, -1, 1, 0}, {1, 1, 0, 1, 1, 1, 0, 1, 1}, {-1, -1, -1, 0, -1, -1, -1, 0, -1}, {0, 0, -1, 1, 0, 0, -1, 1, 0}})[Adder1.Adder2.AND.G2.y_old, Adder1.Adder2.AND.G1.y];
	[----] Adder1.Adder2.AND.G2.delayTime := if $SEV_10 then Adder1.Adder2.AND.G2.tLH else if $SEV_11 then Adder1.Adder2.AND.G2.tHL else 0.0;
	[----] Adder1.Adder2.AND.G2.t_next := time + Adder1.Adder2.AND.G2.delayTime;

	[----] if $SEV_12 then
	[----]   Adder1.Adder2.AND.G2.y_auxiliary := Adder1.Adder2.AND.G1.y;
	[----] end if;

	[----] $SEV_14 := Adder1.Adder2.AND.G2.tLH > 0.0 or Adder1.Adder2.AND.G2.tHL > 0.0;
	[----] Adder1.Adder2.AND.G2.y := if $SEV_14 then Adder1.Adder2.AND.G2.y_auxiliary else Adder1.Adder2.AND.G1.y;
	[----] $PRE.Adder1.Adder2.AND.G1.y := Adder1.Adder2.AND.G1.y;
	[----] $SEV_8 := false;
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 3.0382115049287677]
Failed to read output from testmodel.py, exit status != 0:
['time', 'Adder1.Adder1.AND.G2.x', 'Adder1.Adder1.AND.G2.y', 'Adder1.Adder1.XOR.G2.x', 'Adder1.Adder1.XOR.G2.y', 'Adder1.Adder2.AND.G2.x', 'Adder1.Adder2.AND.G2.y', 'Adder1.Adder2.XOR.G2.x', 'Adder1.Adder2.XOR.G2.y', 'Adder2.Adder1.AND.G2.x', 'Adder2.Adder1.AND.G2.y', 'Adder2.Adder1.XOR.G2.x', 'Adder2.Adder1.XOR.G2.y', 'Adder2.Adder2.AND.G2.x', 'Adder2.Adder2.AND.G2.y', 'Adder2.Adder2.XOR.G2.x', 'Adder2.Adder2.XOR.G2.y', 'Adder3.Adder1.AND.G2.x', 'Adder3.Adder1.AND.G2.y', 'Adder3.Adder1.XOR.G2.x', 'Adder3.Adder1.XOR.G2.y', 'Adder3.Adder2.AND.G2.x', 'Adder3.Adder2.AND.G2.y', 'Adder3.Adder2.XOR.G2.x', 'Adder3.Adder2.XOR.G2.y', 'Adder4.Adder1.AND.G2.x', 'Adder4.Adder1.AND.G2.y', 'Adder4.Adder1.XOR.G2.x', 'Adder4.Adder1.XOR.G2.y', 'Adder4.Adder2.AND.G2.x', 'Adder4.Adder2.AND.G2.y', 'Adder4.Adder2.XOR.G2.x', 'Adder4.Adder2.XOR.G2.y']
0.36078410502523184 0.374712907 0.14360402
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fb3cbe9af20>