Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess.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.00186/0.00186, allocations: 80.88 kB / 21.56 MB, free: 2.934 MB / 18.57 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.002524/0.002524, allocations: 164.7 kB / 24.97 MB, free: 8.188 MB / 18.57 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.601/1.601, allocations: 177.1 MB / 205.4 MB, free: 5.484 MB / 186.7 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo): time 3.207/3.207, allocations: 389.5 MB / 0.6361 GB, free: 12.28 MB / 0.6042 GB
"
[Timeout remaining time 176]
Using package Buildings with version 13.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.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.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess")
translateModel(Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.546e-05/2.546e-05, allocations: 6.25 kB / 0.7759 GB, free: 5.375 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess): time 0.005799/0.005825, allocations: 3.134 MB / 0.779 GB, free: 2.266 MB / 0.7292 GB
Notification: Performance of NFInst.instExpressions: time 0.003129/0.008954, allocations: 1.353 MB / 0.7803 GB, free: 0.9102 MB / 0.7292 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0004523/0.009406, allocations: 27.81 kB / 0.7803 GB, free: 0.8828 MB / 0.7292 GB
Notification: Performance of NFTyping.typeComponents: time 0.0003488/0.009755, allocations: 110.7 kB / 0.7804 GB, free: 0.7734 MB / 0.7292 GB
Notification: Performance of NFTyping.typeBindings: time 0.0003248/0.01008, allocations: 104.6 kB / 0.7805 GB, free: 0.6719 MB / 0.7292 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00125/0.01133, allocations: 0.5643 MB / 0.7811 GB, free: 112 kB / 0.7292 GB
Notification: Performance of NFFlatten.flatten: time 0.00157/0.0129, allocations: 1.22 MB / 0.7823 GB, free: 14.89 MB / 0.7448 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001143/0.01404, allocations: 460.8 kB / 0.7827 GB, free: 14.41 MB / 0.7448 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0009075/0.01495, allocations: 0.6199 MB / 0.7833 GB, free: 13.79 MB / 0.7448 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003726/0.01532, allocations: 263.1 kB / 0.7836 GB, free: 13.54 MB / 0.7448 GB
Notification: Performance of NFPackage.collectConstants: time 0.000188/0.01551, allocations: 128.7 kB / 0.7837 GB, free: 13.41 MB / 0.7448 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.000261/0.01577, allocations: 152 kB / 0.7838 GB, free: 13.26 MB / 0.7448 GB
Notification: Performance of combineBinaries: time 0.001282/0.01705, allocations: 1.289 MB / 0.7851 GB, free: 11.96 MB / 0.7448 GB
Notification: Performance of replaceArrayConstructors: time 0.0006434/0.0177, allocations: 0.7182 MB / 0.7858 GB, free: 11.24 MB / 0.7448 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001447/0.01784, allocations: 60 kB / 0.7859 GB, free: 11.18 MB / 0.7448 GB
Notification: Performance of FrontEnd: time 0.0001725/0.01801, allocations: 55.38 kB / 0.7859 GB, free: 11.13 MB / 0.7448 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 199 (199)
 * Number of variables: 199 (199)
Notification: Performance of [SIM] Bindings: time 0.004828/0.02284, allocations: 3.815 MB / 0.7896 GB, free: 7.156 MB / 0.7448 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0005354/0.02338, allocations: 499.7 kB / 0.7901 GB, free: 6.668 MB / 0.7448 GB
Notification: Performance of [SIM] Early Inline: time 0.003497/0.02688, allocations: 3.035 MB / 0.7931 GB, free: 3.594 MB / 0.7448 GB
Notification: Performance of [SIM] Simplify 1: time 0.0006317/0.02751, allocations: 359.6 kB / 0.7934 GB, free: 3.203 MB / 0.7448 GB
Warning: NBAlias.setStartFixed: Multiple variables are fixed and have identical start values. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.01052/0.03803, allocations: 4.88 MB / 0.7982 GB, free: 13.94 MB / 0.7605 GB
Notification: Performance of [SIM] Simplify 2: time 0.0005245/0.03855, allocations: 225.4 kB / 0.7984 GB, free: 13.69 MB / 0.7605 GB
Notification: Performance of [SIM] Remove Stream: time 0.0004648/0.03902, allocations: 244.1 kB / 0.7986 GB, free: 13.43 MB / 0.7605 GB
Notification: Performance of [SIM] Detect States: time 0.001276/0.04029, allocations: 0.6543 MB / 0.7993 GB, free: 12.71 MB / 0.7605 GB
Notification: Performance of [SIM] Events: time 0.000484/0.04078, allocations: 225.3 kB / 0.7995 GB, free: 12.5 MB / 0.7605 GB
Notification: Performance of [SIM] Partitioning: time 0.001226/0.042, allocations: 0.5867 MB / 0.8001 GB, free: 11.88 MB / 0.7605 GB
Notification: Performance of [SIM] Causalize: time 0.001705/0.04371, allocations: 0.7275 MB / 0.8008 GB, free: 11.16 MB / 0.7605 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.002202/0.04591, allocations: 1.386 MB / 0.8021 GB, free: 9.773 MB / 0.7605 GB
Notification: Performance of [INI] Simplify: time 0.00163/0.04754, allocations: 0.6921 MB / 0.8028 GB, free: 9.031 MB / 0.7605 GB
Notification: Performance of [INI] Inline: time 0.002942/0.05048, allocations: 1.774 MB / 0.8045 GB, free: 7.254 MB / 0.7605 GB
Notification: Performance of [INI] Partitioning: time 0.000107/0.05059, allocations: 43.88 kB / 0.8046 GB, free: 7.203 MB / 0.7605 GB
Notification: Performance of [INI] Cleanup: time 0.0006095/0.0512, allocations: 379.6 kB / 0.8049 GB, free: 6.832 MB / 0.7605 GB
Notification: Performance of [INI] Causalize: time 0.004108/0.05531, allocations: 1.775 MB / 0.8067 GB, free: 5.051 MB / 0.7605 GB
Notification: Performance of [INI] Tearing: time 5.731e-05/0.05536, allocations: 44 kB / 0.8067 GB, free: 5.008 MB / 0.7605 GB
Notification: Performance of [SIM] Initialization: time 1.173e-06/0.05536, allocations: 0 / 0.8067 GB, free: 5.008 MB / 0.7605 GB
Notification: Performance of [SIM] Remove Dummies: time 1.683e-05/0.05538, allocations: 4.594 kB / 0.8067 GB, free: 5.004 MB / 0.7605 GB
Notification: Performance of [SIM] Tearing: time 3.736e-05/0.05542, allocations: 32 kB / 0.8068 GB, free: 4.973 MB / 0.7605 GB
Notification: Performance of [SIM] Categorize: time 1.285e-05/0.05543, allocations: 7.938 kB / 0.8068 GB, free: 4.965 MB / 0.7605 GB
Notification: Performance of [SIM] Solve: time 0.0009629/0.05639, allocations: 417.3 kB / 0.8072 GB, free: 4.555 MB / 0.7605 GB
Notification: Performance of [SIM] Jacobian: time 8.967e-06/0.0564, allocations: 0 / 0.8072 GB, free: 4.555 MB / 0.7605 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 6.81e-07/0.0564, allocations: 4 kB / 0.8072 GB, free: 4.551 MB / 0.7605 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: .................... 13 (13) {tunEnd.y, tunSta.y, resSig.y, relSwi.y, resPro.tunMon.sub.u2, resPro.norTimDel.tunEndDel.y, resPro.norTimDel.tunEndDel.t_next, resPro.halPerRatio.maxtOntOff.u2, resPro.halPerRatio.maxtOntOff.u1, resPro.tOff, resPro.tOn, resPro.onOffPer.lenOnCal.u1, resPro.onOffPer.lenOffCal.u1}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 34 (34) {resPro.onOffPer.timOnRec.samTri.y, resPro.onOffPer.timOnRec.swi.u2, resPro.onOffPer.timOnRec.edgThr.u, resPro.onOffPer.timOnRec.edgThr.y, resPro.onOffPer.timOffRec.samTri.y, resPro.onOffPer.timOffRec.swi.u2, resPro.onOffPer.timOffRec.edgThr.u, resPro.onOffPer.timOffRec.edgThr.y, resPro.norTimDel.gre.greHys.y, resPro.norTimDel.or2.u1, resPro.norTimDel.or2.y, resPro.norTimDel.tunEndDel.u, resPro.tunMon.samAddtOntOff.trigger, resPro.tunMon.tCha.u1, resPro.tunMon.tCha.u2, resPro.tunMon.tCha.y, resPro.tunMon.edgTunSta.u, tunSta.u, tunEnd.u, $WC_2, $WC_1, $WC_0, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $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: ........... 50 (scalar:50, array:0, record:0)
 * Number of multi strong components: ............ 13 (algorithm:0, when:13, 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: ........... 79 (scalar:79, array:0, record:0)
 * Number of multi strong components: ............ 4 (algorithm:4, 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.0001054/0.05651, allocations: 60.59 kB / 0.8072 GB, free: 4.5 MB / 0.7605 GB
Notification: Performance of SimCode: time 0.002786/0.0593, allocations: 1.159 MB / 0.8084 GB, free: 3.273 MB / 0.7605 GB
Notification: Performance of Templates: time 0.01617/0.07546, allocations: 4.905 MB / 0.8131 GB, free: 14.47 MB / 0.7761 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_13_Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess.pipe ; mkfifo Buildings_13_Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess.pipe ; head -c 1048576 < Buildings_13_Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess.pipe >> ../files/Buildings_13_Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess.sim & ./Buildings_13_Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Controls.OBC.Utilities.PIDWithAutotuning.Relay.Validation.ResponseProcess.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 8.218160902149975]