Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildingSystems_BuildingSystems.Controls.Continuous.Examples.LimPID.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.001318/0.001318, allocations: 104.3 kB / 19.77 MB, free: 2.051 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.001381/0.001381, allocations: 215.8 kB / 23.07 MB, free: 4.844 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.4/1.4, allocations: 230.7 MB / 256.9 MB, free: 7.738 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 master/package.mo): time 0.00246/0.00246, allocations: 278.9 kB / 313.6 MB, free: 2.566 MB / 238.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo): time 1.18/1.18, allocations: 180.6 MB / 0.5378 GB, free: 14.46 MB / 382.1 MB
"
[Timeout remaining time 179]
Using package BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo)
Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 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(BuildingSystems.Controls.Continuous.Examples.LimPID,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Controls.Continuous.Examples.LimPID")
translateModel(BuildingSystems.Controls.Continuous.Examples.LimPID,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Controls.Continuous.Examples.LimPID") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.582e-05/1.582e-05, allocations: 2.281 kB / 0.7408 GB, free: 28.38 MB / 0.5294 GB
Notification: Performance of NFInst.instantiate(BuildingSystems.Controls.Continuous.Examples.LimPID): time 0.00352/0.003536, allocations: 3.375 MB / 0.7441 GB, free: 26.11 MB / 0.5294 GB
Notification: Performance of NFInst.instExpressions: time 0.001997/0.005533, allocations: 1.338 MB / 0.7454 GB, free: 25.15 MB / 0.5294 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002735/0.005806, allocations: 32.31 kB / 0.7454 GB, free: 25.14 MB / 0.5294 GB
Notification: Performance of NFTyping.typeComponents: time 0.0002677/0.006074, allocations: 132.4 kB / 0.7455 GB, free: 25.04 MB / 0.5294 GB
Notification: Performance of NFTyping.typeBindings: time 0.0004252/0.006499, allocations: 186.9 kB / 0.7457 GB, free: 24.91 MB / 0.5294 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0008575/0.007356, allocations: 0.5718 MB / 0.7463 GB, free: 24.59 MB / 0.5294 GB
Notification: Performance of NFFlatten.flatten: time 0.0007223/0.008079, allocations: 1.169 MB / 0.7474 GB, free: 24 MB / 0.5294 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003499/0.008429, allocations: 234.1 kB / 0.7476 GB, free: 23.85 MB / 0.5294 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003894/0.008818, allocations: 484.4 kB / 0.7481 GB, free: 23.61 MB / 0.5294 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0002294/0.009047, allocations: 316.3 kB / 0.7484 GB, free: 23.44 MB / 0.5294 GB
Notification: Performance of NFPackage.collectConstants: time 9.266e-05/0.00914, allocations: 78.19 kB / 0.7485 GB, free: 23.44 MB / 0.5294 GB
Notification: Performance of NFFlatten.collectFunctions: time 8.615e-05/0.009226, allocations: 74.78 kB / 0.7485 GB, free: 23.44 MB / 0.5294 GB
Notification: Performance of combineBinaries: time 0.0006361/0.009862, allocations: 1.591 MB / 0.7501 GB, free: 22.3 MB / 0.5294 GB
Notification: Performance of replaceArrayConstructors: time 0.0003164/0.01018, allocations: 1.046 MB / 0.7511 GB, free: 21.55 MB / 0.5294 GB
Notification: Performance of NFVerifyModel.verify: time 7.775e-05/0.01026, allocations: 44.38 kB / 0.7511 GB, free: 21.55 MB / 0.5294 GB
Notification: Performance of FrontEnd: time 0.0001046/0.01036, allocations: 49.56 kB / 0.7512 GB, free: 21.52 MB / 0.5294 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 126 (128)
 * Number of variables: 126 (126)
Notification: Performance of [SIM] Bindings: time 0.002204/0.01257, allocations: 3.545 MB / 0.7547 GB, free: 19.02 MB / 0.5294 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0002445/0.01281, allocations: 375.6 kB / 0.755 GB, free: 18.79 MB / 0.5294 GB
Notification: Performance of [SIM] Early Inline: time 0.001098/0.01391, allocations: 1.665 MB / 0.7566 GB, free: 17.8 MB / 0.5294 GB
Notification: Performance of [SIM] Simplify 1: time 0.0004181/0.01433, allocations: 323.3 kB / 0.7569 GB, free: 17.62 MB / 0.5294 GB
Notification: Performance of [SIM] Alias: time 0.002975/0.0173, allocations: 3.031 MB / 0.7599 GB, free: 15.75 MB / 0.5294 GB
Notification: Performance of [SIM] Simplify 2: time 0.0002712/0.01757, allocations: 251.8 kB / 0.7601 GB, free: 15.61 MB / 0.5294 GB
Notification: Performance of [SIM] Remove Stream: time 0.0001383/0.01771, allocations: 172.1 kB / 0.7603 GB, free: 15.49 MB / 0.5294 GB
Notification: Performance of [SIM] Detect States: time 0.0003858/0.0181, allocations: 428.1 kB / 0.7607 GB, free: 15.16 MB / 0.5294 GB
Notification: Performance of [SIM] Events: time 0.0001868/0.01828, allocations: 125.6 kB / 0.7608 GB, free: 15.1 MB / 0.5294 GB
Notification: Performance of [SIM] Partitioning: time 0.0004934/0.01878, allocations: 0.5658 MB / 0.7614 GB, free: 14.8 MB / 0.5294 GB
Notification: Performance of [SIM] Causalize: time 0.0009454/0.01972, allocations: 0.8051 MB / 0.7622 GB, free: 14.56 MB / 0.5294 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0008738/0.0206, allocations: 1.107 MB / 0.7633 GB, free: 13.97 MB / 0.5294 GB
Notification: Performance of [INI] Simplify: time 0.001345/0.02194, allocations: 0.9554 MB / 0.7642 GB, free: 13.44 MB / 0.5294 GB
Notification: Performance of [INI] Inline: time 0.001446/0.02339, allocations: 1.745 MB / 0.7659 GB, free: 12.49 MB / 0.5294 GB
Notification: Performance of [INI] Partitioning: time 7.724e-05/0.02346, allocations: 46.92 kB / 0.7659 GB, free: 12.46 MB / 0.5294 GB
Notification: Performance of [INI] Cleanup: time 0.0003379/0.0238, allocations: 462.6 kB / 0.7664 GB, free: 12.18 MB / 0.5294 GB
Notification: Performance of [INI] Causalize: time 0.004229/0.02803, allocations: 3.312 MB / 0.7696 GB, free: 11.47 MB / 0.5294 GB
Notification: Performance of [INI] Tearing: time 5.925e-05/0.02809, allocations: 112.6 kB / 0.7697 GB, free: 11.39 MB / 0.5294 GB
Notification: Performance of [SIM] Initialization: time 8.42e-07/0.02809, allocations: 0 / 0.7697 GB, free: 11.39 MB / 0.5294 GB
Notification: Performance of [SIM] DAE-Mode: time 0.0004586/0.02855, allocations: 352.5 kB / 0.7701 GB, free: 11.21 MB / 0.5294 GB
Notification: Performance of [SIM] Remove Dummies: time 6.522e-06/0.02856, allocations: 5.531 kB / 0.7701 GB, free: 11.21 MB / 0.5294 GB
Notification: Performance of [SIM] Tearing: time 2.05e-05/0.02858, allocations: 50.06 kB / 0.7701 GB, free: 11.18 MB / 0.5294 GB
Notification: Performance of [SIM] Categorize: time 1.695e-05/0.02859, allocations: 10.08 kB / 0.7701 GB, free: 11.17 MB / 0.5294 GB
Notification: Performance of [SIM] Solve: time 0.001653/0.03025, allocations: 1.418 MB / 0.7715 GB, free: 10.66 MB / 0.5294 GB
Notification: Performance of [SIM] Jacobian: time 0.0006689/0.03092, allocations: 0.7718 MB / 0.7723 GB, free: 10.1 MB / 0.5294 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 4
 * 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: ............................. 6 (6) {limPID.I.y, limPID.D.x, limPIDRev.I.y, limPIDRev.D.x, limPIDOri.I.y, limPIDOri.D.x}
 * Number of discrete states: .................... 2 (2) {pulse.T_start, pulse.count}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 9 (9) {$SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_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: ........... 52 (scalar:52, array:0, record:0)
 * Number of multi strong components: ............ 2 (algorithm:0, when:2, 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: ........... 110 (scalar:110, array:0, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, 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 (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 110 (scalar:110, array:0, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, 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 0.0001268/0.03104, allocations: 67.66 kB / 0.7723 GB, free: 10.04 MB / 0.5294 GB
Notification: Performance of SimCode: time 0.002585/0.03363, allocations: 2.568 MB / 0.7748 GB, free: 8.766 MB / 0.5294 GB
Notification: Performance of Templates: time 0.01267/0.0463, allocations: 6.474 MB / 0.7812 GB, free: 7.684 MB / 0.5294 GB
"
[Timeout remaining time 660]
make -j1 -f BuildingSystems_BuildingSystems.Controls.Continuous.Examples.LimPID.makefile [Timeout 660]
(rm -f BuildingSystems_BuildingSystems.Controls.Continuous.Examples.LimPID.pipe ; mkfifo BuildingSystems_BuildingSystems.Controls.Continuous.Examples.LimPID.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.Controls.Continuous.Examples.LimPID.pipe >> ../files/BuildingSystems_BuildingSystems.Controls.Continuous.Examples.LimPID.sim & ./BuildingSystems_BuildingSystems.Controls.Continuous.Examples.LimPID  -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildingSystems_BuildingSystems.Controls.Continuous.Examples.LimPID.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 5.872523102036212]
Failed to read output from testmodel.py, exit status != 0:
0.052349592035170645 0.06344092700000001 0.050619874
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fd56fceefb0>