Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage.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.001677/0.001677, allocations: 104.3 kB / 19.72 MB, free: 2.145 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.001812/0.001812, allocations: 210.1 kB / 23 MB, free: 4.965 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.227/1.227, allocations: 230.6 MB / 256.8 MB, free: 7.812 MB / 206.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.646/2.646, allocations: 0.49 GB / 0.7958 GB, free: 35.49 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/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(Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|chiStaCon.on|chiStaCon.plr.y|chiStaCon.y.1.|chiStaCon.y.2.",fileNamePrefix="Buildings_12_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage")
translateModel(Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|chiStaCon.on|chiStaCon.plr.y|chiStaCon.y.1.|chiStaCon.y.2.",fileNamePrefix="Buildings_12_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.052e-05/1.052e-05, allocations: 4.109 kB / 1.155 GB, free: 25.38 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage): time 0.002835/0.002846, allocations: 2.629 MB / 1.158 GB, free: 23.63 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.001879/0.004725, allocations: 1.597 MB / 1.159 GB, free: 22.57 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001286/0.004854, allocations: 11.22 kB / 1.159 GB, free: 22.56 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 0.000526/0.00538, allocations: 206.4 kB / 1.159 GB, free: 22.48 MB / 0.9044 GB
Notification: Performance of NFTyping.typeBindings: time 0.0003546/0.005734, allocations: 214 kB / 1.16 GB, free: 22.36 MB / 0.9044 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0005287/0.006263, allocations: 413.2 kB / 1.16 GB, free: 22.12 MB / 0.9044 GB
Notification: Performance of NFFlatten.flatten: time 0.0006287/0.006891, allocations: 0.9207 MB / 1.161 GB, free: 21.7 MB / 0.9044 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0004508/0.007342, allocations: 484 kB / 1.161 GB, free: 21.46 MB / 0.9044 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003211/0.007663, allocations: 375.9 kB / 1.162 GB, free: 21.29 MB / 0.9044 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0002366/0.0079, allocations: 334.1 kB / 1.162 GB, free: 21.11 MB / 0.9044 GB
Notification: Performance of NFPackage.collectConstants: time 9.171e-05/0.007992, allocations: 79.84 kB / 1.162 GB, free: 21.11 MB / 0.9044 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001847/0.008176, allocations: 143.6 kB / 1.162 GB, free: 21.09 MB / 0.9044 GB
Notification: Performance of combineBinaries: time 0.0004945/0.008671, allocations: 1.143 MB / 1.163 GB, free: 20.28 MB / 0.9044 GB
Notification: Performance of replaceArrayConstructors: time 0.000222/0.008893, allocations: 0.6708 MB / 1.164 GB, free: 19.8 MB / 0.9044 GB
Notification: Performance of NFVerifyModel.verify: time 6.954e-05/0.008962, allocations: 41.19 kB / 1.164 GB, free: 19.8 MB / 0.9044 GB
Notification: Performance of FrontEnd: time 7.26e-05/0.009035, allocations: 71.73 kB / 1.164 GB, free: 19.76 MB / 0.9044 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 130 (128)
 * Number of variables: 130 (125)
Notification: Performance of [SIM] Bindings: time 0.001735/0.01077, allocations: 2.564 MB / 1.167 GB, free: 17.96 MB / 0.9044 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0002802/0.01105, allocations: 403.2 kB / 1.167 GB, free: 17.69 MB / 0.9044 GB
Notification: Performance of [SIM] Early Inline: time 0.001257/0.01231, allocations: 1.925 MB / 1.169 GB, free: 16.45 MB / 0.9044 GB
Notification: Performance of [SIM] Simplify 1: time 0.0003573/0.01267, allocations: 320.7 kB / 1.169 GB, free: 16.23 MB / 0.9044 GB
Notification: Performance of [SIM] Alias: time 0.002339/0.015, allocations: 2.4 MB / 1.171 GB, free: 14.79 MB / 0.9044 GB
Notification: Performance of [SIM] Simplify 2: time 0.0002529/0.01526, allocations: 239.6 kB / 1.172 GB, free: 14.62 MB / 0.9044 GB
Notification: Performance of [SIM] Remove Stream: time 0.0001289/0.01539, allocations: 172.1 kB / 1.172 GB, free: 14.48 MB / 0.9044 GB
Notification: Performance of [SIM] Detect States: time 0.0004204/0.01581, allocations: 0.4965 MB / 1.172 GB, free: 14.11 MB / 0.9044 GB
Notification: Performance of [SIM] Events: time 0.0002515/0.01606, allocations: 226.1 kB / 1.173 GB, free: 13.99 MB / 0.9044 GB
Notification: Performance of [SIM] Partitioning: time 0.0005394/0.0166, allocations: 0.5888 MB / 1.173 GB, free: 13.7 MB / 0.9044 GB
Notification: Performance of [SIM] Causalize: time 0.00172/0.01832, allocations: 1.576 MB / 1.175 GB, free: 13.33 MB / 0.9044 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0008261/0.01914, allocations: 1.295 MB / 1.176 GB, free: 12.59 MB / 0.9044 GB
Notification: Performance of [INI] Simplify: time 0.002436/0.02158, allocations: 0.9793 MB / 1.177 GB, free: 11.99 MB / 0.9044 GB
Notification: Performance of [INI] Inline: time 0.001371/0.02295, allocations: 2.075 MB / 1.179 GB, free: 10.75 MB / 0.9044 GB
Notification: Performance of [INI] Partitioning: time 8.063e-05/0.02303, allocations: 52.95 kB / 1.179 GB, free: 10.71 MB / 0.9044 GB
Notification: Performance of [INI] Cleanup: time 0.0001878/0.02322, allocations: 319.6 kB / 1.179 GB, free: 10.5 MB / 0.9044 GB
Notification: Performance of [INI] Causalize: time 0.004259/0.02748, allocations: 3.913 MB / 1.183 GB, free: 9.484 MB / 0.9044 GB
Notification: Performance of [INI] Tearing: time 0.000771/0.02825, allocations: 0.7069 MB / 1.184 GB, free: 9.258 MB / 0.9044 GB
Notification: Performance of [SIM] Initialization: time 9.22e-07/0.02825, allocations: 5.594 kB / 1.184 GB, free: 9.254 MB / 0.9044 GB
Notification: Performance of [SIM] Remove Dummies: time 7.605e-06/0.02826, allocations: 1 kB / 1.184 GB, free: 9.254 MB / 0.9044 GB
Notification: Performance of [SIM] Tearing: time 0.0005635/0.02882, allocations: 0.5125 MB / 1.184 GB, free: 9.121 MB / 0.9044 GB
Notification: Performance of [SIM] Categorize: time 8.577e-06/0.02883, allocations: 5.141 kB / 1.184 GB, free: 9.121 MB / 0.9044 GB
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 = 2)
-------------------------------------------------------------------
### Variable:
	$SEV_3[$i1]
### Equation:
	[FOR-] (2) ($RES_SIM_73)
[----] for $i1 in 1:2 loop
[----]   [SCAL] (1) chiStaCon.oneOn.inPort[$i1].occupied = if $SEV_2[$i1] then chiStaCon.oneOn.localActive else $SEV_3[$i1] ($RES_SIM_74)
[----] 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 = 8)
----------------------------------------------------------------------------------
Strict Tearing Set
********************
### Iteration Variables:
	[DISC] (1) Boolean chiStaCon.offToOne.outPort.occupied;
### Residual Equations:

### Inner Equations:
	BLOCK: Sliced Component (status = Solve.UNPROCESSED, size = 1)
----------------------------------------------------------------
### Variable:
	chiStaCon.oneOn.inPort[1].occupied
### Equation:
	[SCAL] (1) chiStaCon.offToOne.outPort.occupied = chiStaCon.oneOn.inPort[1].occupied ($RES_SIM_107)

	BLOCK: Single Strong Component (status = Solve.UNPROCESSED, size = 1)
-----------------------------------------------------------------------
### Variable:
	Boolean $SEV_7
### Equation:
	[SCAL] (1) $SEV_7 = (chiStaCon.on and chiStaCon.offToOne.inPort.available) and not chiStaCon.offToOne.outPort.occupied ($RES_EVT_178)

	BLOCK: Single Strong Component (status = Solve.UNPROCESSED, size = 1)
-----------------------------------------------------------------------
### Variable:
	Boolean chiStaCon.offToOne.enableFire
### Equation:
	[SCAL] (1) chiStaCon.offToOne.enableFire = $SEV_7 ($RES_SIM_59)

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

	BLOCK: Single Strong Component (status = Solve.UNPROCESSED, size = 1)
-----------------------------------------------------------------------
### Variable:
	Boolean chiStaCon.offToOne.fire
### Equation:
	[SCAL] (1) chiStaCon.offToOne.fire = $SEV_6 ($RES_SIM_60)

	BLOCK: Sliced Component (status = Solve.UNPROCESSED, size = 1)
----------------------------------------------------------------
### Variable:
	chiStaCon.oneOn.inPort[1].set
### Equation:
	[SCAL] (1) chiStaCon.offToOne.fire = chiStaCon.oneOn.inPort[1].set ($RES_SIM_106)

	BLOCK: Resizable Component (status = Solve.UNPROCESSED, size = 2)
-------------------------------------------------------------------
### Variable:
	$SEV_3[$i1]
### Equation:
	[FOR-] (2) ($RES_SIM_73)
[----] for $i1 in 1:2 loop
[----]   [SCAL] (1) chiStaCon.oneOn.inPort[$i1].occupied = if $SEV_2[$i1] then chiStaCon.oneOn.localActive else $SEV_3[$i1] ($RES_SIM_74)
[----] end for;
"
[Timeout remaining time 300]
[Calling sys.exit(0), Time elapsed: 5.32080151932314]
Failed to read output from testmodel.py, exit status != 0:
0.035435987170785666 0.045466689000000005 0.034248689
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fb9f6f1ef20>