Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Controls.OBC.CDL.Reals.Validation.Divide.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.001539/0.001539, allocations: 104.3 kB / 19.76 MB, free: 1.906 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.001673/0.001673, allocations: 212.4 kB / 23.06 MB, free: 4.984 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.356/1.356, allocations: 230.7 MB / 256.9 MB, free: 7.742 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 3.038/3.038, allocations: 0.5108 GB / 0.8167 GB, free: 17.77 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 13.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 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(Buildings.Controls.OBC.CDL.Reals.Validation.Divide,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|div1.u1|div1.u2|div1.y",fileNamePrefix="Buildings_latest_Buildings.Controls.OBC.CDL.Reals.Validation.Divide")
translateModel(Buildings.Controls.OBC.CDL.Reals.Validation.Divide,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|div1.u1|div1.u2|div1.y",fileNamePrefix="Buildings_latest_Buildings.Controls.OBC.CDL.Reals.Validation.Divide") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.716e-05/1.716e-05, allocations: 2.281 kB / 1.187 GB, free: 13.49 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.CDL.Reals.Validation.Divide): time 0.001507/0.001525, allocations: 0.7004 MB / 1.188 GB, free: 13.06 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.0008432/0.002368, allocations: 0.833 MB / 1.189 GB, free: 12.43 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 3.592e-05/0.002404, allocations: 1.312 kB / 1.189 GB, free: 12.43 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 2.884e-05/0.002432, allocations: 5.641 kB / 1.189 GB, free: 12.43 MB / 0.9044 GB
Notification: Performance of NFTyping.typeBindings: time 6.652e-05/0.002499, allocations: 5.891 kB / 1.189 GB, free: 12.43 MB / 0.9044 GB
Notification: Performance of NFTyping.typeClassSections: time 6.129e-05/0.00256, allocations: 16.34 kB / 1.189 GB, free: 12.42 MB / 0.9044 GB
Notification: Performance of NFFlatten.flatten: time 8.551e-05/0.002646, allocations: 44.59 kB / 1.189 GB, free: 12.4 MB / 0.9044 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0001055/0.002751, allocations: 5.312 kB / 1.189 GB, free: 12.4 MB / 0.9044 GB
Notification: Performance of NFEvalConstants.evaluate: time 5.872e-05/0.00281, allocations: 24.81 kB / 1.189 GB, free: 12.39 MB / 0.9044 GB
Notification: Performance of NFSimplifyModel.simplify: time 4.351e-05/0.002854, allocations: 19.2 kB / 1.189 GB, free: 12.38 MB / 0.9044 GB
Notification: Performance of NFPackage.collectConstants: time 1.772e-05/0.002871, allocations: 2.625 kB / 1.189 GB, free: 12.38 MB / 0.9044 GB
Notification: Performance of NFFlatten.collectFunctions: time 8.767e-06/0.00288, allocations: 4.656 kB / 1.189 GB, free: 12.38 MB / 0.9044 GB
Notification: Performance of combineBinaries: time 7.697e-05/0.002957, allocations: 79.2 kB / 1.189 GB, free: 12.32 MB / 0.9044 GB
Notification: Performance of replaceArrayConstructors: time 3.59e-05/0.002993, allocations: 53.69 kB / 1.189 GB, free: 12.29 MB / 0.9044 GB
Notification: Performance of NFVerifyModel.verify: time 1.999e-05/0.003013, allocations: 3.156 kB / 1.189 GB, free: 12.29 MB / 0.9044 GB
Notification: Performance of FrontEnd: time 1.301e-05/0.003026, allocations: 3.938 kB / 1.189 GB, free: 12.28 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: 5 (5)
 * Number of variables: 5 (5)
Notification: Performance of [SIM] Bindings: time 0.0003719/0.003398, allocations: 325.4 kB / 1.189 GB, free: 11.93 MB / 0.9044 GB
Notification: Performance of [SIM] FunctionAlias: time 5.127e-05/0.003449, allocations: 45.55 kB / 1.189 GB, free: 11.89 MB / 0.9044 GB
Notification: Performance of [SIM] Early Inline: time 0.0001176/0.003567, allocations: 143.8 kB / 1.189 GB, free: 11.78 MB / 0.9044 GB
Notification: Performance of [SIM] Simplify 1: time 8.364e-05/0.00365, allocations: 76.72 kB / 1.189 GB, free: 11.68 MB / 0.9044 GB
Notification: Performance of [SIM] Alias: time 0.000343/0.003993, allocations: 202.9 kB / 1.19 GB, free: 11.48 MB / 0.9044 GB
Notification: Performance of [SIM] Simplify 2: time 5.077e-05/0.004044, allocations: 72 kB / 1.19 GB, free: 11.39 MB / 0.9044 GB
Notification: Performance of [SIM] Remove Stream: time 2.284e-05/0.004067, allocations: 39.72 kB / 1.19 GB, free: 11.33 MB / 0.9044 GB
Notification: Performance of [SIM] Detect States: time 6.926e-05/0.004136, allocations: 100.6 kB / 1.19 GB, free: 11.2 MB / 0.9044 GB
Notification: Performance of [SIM] Events: time 8.768e-05/0.004224, allocations: 51.28 kB / 1.19 GB, free: 11.17 MB / 0.9044 GB
Notification: Performance of [SIM] Partitioning: time 0.0001017/0.004325, allocations: 66.62 kB / 1.19 GB, free: 11.13 MB / 0.9044 GB
Notification: Performance of [SIM] Causalize: time 0.0001477/0.004473, allocations: 98.09 kB / 1.19 GB, free: 11.09 MB / 0.9044 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0001004/0.004573, allocations: 128.4 kB / 1.19 GB, free: 11.03 MB / 0.9044 GB
Notification: Performance of [INI] Simplify: time 0.0001179/0.004691, allocations: 134.4 kB / 1.19 GB, free: 10.87 MB / 0.9044 GB
Notification: Performance of [INI] Inline: time 0.0001209/0.004812, allocations: 162.2 kB / 1.19 GB, free: 10.79 MB / 0.9044 GB
Notification: Performance of [INI] Partitioning: time 1.094e-05/0.004823, allocations: 15.59 kB / 1.191 GB, free: 10.77 MB / 0.9044 GB
Notification: Performance of [INI] Cleanup: time 2.848e-05/0.004852, allocations: 30.31 kB / 1.191 GB, free: 10.75 MB / 0.9044 GB
Notification: Performance of [INI] Causalize: time 0.0001687/0.00502, allocations: 115.2 kB / 1.191 GB, free: 10.71 MB / 0.9044 GB
Notification: Performance of [INI] Tearing: time 9.158e-06/0.00503, allocations: 5.094 kB / 1.191 GB, free: 10.71 MB / 0.9044 GB
Notification: Performance of [SIM] Initialization: time 7.71e-07/0.00503, allocations: 1.094 kB / 1.191 GB, free: 10.71 MB / 0.9044 GB
Notification: Performance of [SIM] DAE-Mode: time 6.433e-05/0.005095, allocations: 48.97 kB / 1.191 GB, free: 10.68 MB / 0.9044 GB
Notification: Performance of [SIM] Remove Dummies: time 5.259e-06/0.0051, allocations: 5.375 kB / 1.191 GB, free: 10.67 MB / 0.9044 GB
Notification: Performance of [SIM] Tearing: time 2.805e-06/0.005103, allocations: 5.375 kB / 1.191 GB, free: 10.67 MB / 0.9044 GB
Notification: Performance of [SIM] Categorize: time 5.711e-06/0.005109, allocations: 1.375 kB / 1.191 GB, free: 10.67 MB / 0.9044 GB
Notification: Performance of [SIM] Solve: time 0.0001716/0.00528, allocations: 146.5 kB / 1.191 GB, free: 10.62 MB / 0.9044 GB
Notification: Performance of [SIM] Jacobian: time 9.668e-05/0.005377, allocations: 183.2 kB / 1.191 GB, free: 10.42 MB / 0.9044 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 1
 * 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: ................. 4 (4) {$TEV_3, $TEV_2, $TEV_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: ........... 7 (scalar:7, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 7 (scalar:7, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 3.172e-05/0.005409, allocations: 22.73 kB / 1.191 GB, free: 10.41 MB / 0.9044 GB
Notification: Performance of SimCode: time 0.0003472/0.005756, allocations: 258.5 kB / 1.191 GB, free: 10.24 MB / 0.9044 GB
Notification: Performance of Templates: time 0.002831/0.008587, allocations: 0.5858 MB / 1.192 GB, free: 10.15 MB / 0.9044 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_latest_Buildings.Controls.OBC.CDL.Reals.Validation.Divide.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.Controls.OBC.CDL.Reals.Validation.Divide.pipe ; mkfifo Buildings_latest_Buildings.Controls.OBC.CDL.Reals.Validation.Divide.pipe ; head -c 1048576 < Buildings_latest_Buildings.Controls.OBC.CDL.Reals.Validation.Divide.pipe >> ../files/Buildings_latest_Buildings.Controls.OBC.CDL.Reals.Validation.Divide.sim & ./Buildings_latest_Buildings.Controls.OBC.CDL.Reals.Validation.Divide  -abortSlowSimulation -alarm=800  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Controls.OBC.CDL.Reals.Validation.Divide.pipe 2>&1) [Timeout 800]
[Calling os._exit(0), Time elapsed: 7.9497900400310755]
Failed to read output from testmodel.py, exit status != 0:
0.015186520991846919 0.026180955000000002 0.020763517000000002
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff33a0eefb0>