Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AES_AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control.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.0012/0.0012, allocations: 104.2 kB / 19.76 MB, free: 1.91 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.001331/0.001331, allocations: 218.2 kB / 23.05 MB, free: 4.477 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.322/1.322, allocations: 230.6 MB / 256.8 MB, free: 7.746 MB / 206.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/AES main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/AES main/package.mo): time 0.09783/0.09783, allocations: 24.04 MB / 337.3 MB, free: 11.3 MB / 270.1 MB
"
[Timeout remaining time 180]
Using package AES with version  (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AES main/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)
Ignoring simflag  -noemit -noEquidistantTimeGrid=() since it seems broken on HelloWorld
Running command: translateModel(AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="AES_AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control")
translateModel(AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="AES_AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 3.201e-05/3.201e-05, allocations: 2.281 kB / 476 MB, free: 4.297 MB / 334.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AES main/ProcessComponents/Thermal/Interfaces/flowTwoPorts_pwh.mo:4:3-4:45:writable] Warning: An inner declaration for outer component system could not be found and was automatically generated.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AES main/ProcessComponents/Thermal/Interfaces/flowTwoPorts_pwh.mo:4:3-4:45:writable] Notification: The diagnostics message for the missing inner is: Your model is using an outer \"system\" component but an inner \"system\" component is not defined. Drag AES.ProcessComponents.Thermal.System_settings.System_liquid into your model to specify the working fluid properties.
Notification: Performance of NFInst.instantiate(AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control): time 0.06872/0.06875, allocations: 23.88 MB / 499.8 MB, free: 12.57 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.001664/0.07042, allocations: 0.5916 MB / 0.4887 GB, free: 11.98 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001911/0.07061, allocations: 11.94 kB / 0.4887 GB, free: 11.97 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0002114/0.07082, allocations: 75.17 kB / 0.4888 GB, free: 11.9 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.000331/0.07115, allocations: 130.9 kB / 0.4889 GB, free: 11.77 MB / 366.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0004489/0.0716, allocations: 211.7 kB / 0.4891 GB, free: 11.56 MB / 366.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0006909/0.07229, allocations: 0.6974 MB / 0.4898 GB, free: 10.86 MB / 366.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0004603/0.07275, allocations: 318.8 kB / 0.4901 GB, free: 10.55 MB / 366.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0002584/0.07301, allocations: 255.1 kB / 0.4903 GB, free: 10.3 MB / 366.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0002695/0.07328, allocations: 234.7 kB / 0.4906 GB, free: 10.07 MB / 366.1 MB
Notification: Performance of NFPackage.collectConstants: time 7.523e-05/0.07335, allocations: 52 kB / 0.4906 GB, free: 10.02 MB / 366.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001602/0.07351, allocations: 83.97 kB / 0.4907 GB, free: 9.934 MB / 366.1 MB
Notification: Performance of combineBinaries: time 0.0008287/0.07434, allocations: 1.055 MB / 0.4917 GB, free: 8.867 MB / 366.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0004775/0.07482, allocations: 0.6745 MB / 0.4924 GB, free: 8.184 MB / 366.1 MB
Notification: Performance of NFVerifyModel.verify: time 8.107e-05/0.0749, allocations: 44 kB / 0.4924 GB, free: 8.141 MB / 366.1 MB
Notification: Performance of FrontEnd: time 7.511e-05/0.07498, allocations: 19.88 kB / 0.4924 GB, free: 8.121 MB / 366.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 110 (110)
 * Number of variables: 110 (110)
Notification: Performance of [SIM] Bindings: time 0.002363/0.07734, allocations: 2.439 MB / 0.4948 GB, free: 5.543 MB / 366.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0003286/0.07767, allocations: 303.6 kB / 0.4951 GB, free: 5.234 MB / 366.1 MB
Notification: Performance of [SIM] Early Inline: time 0.001433/0.0791, allocations: 1.421 MB / 0.4965 GB, free: 3.785 MB / 366.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0004437/0.07954, allocations: 294.8 kB / 0.4968 GB, free: 3.449 MB / 366.1 MB
Notification: Performance of [SIM] Alias: time 0.003261/0.08281, allocations: 2.459 MB / 0.4992 GB, free: 0.6875 MB / 366.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0002952/0.0831, allocations: 216.2 kB / 0.4994 GB, free: 440 kB / 366.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0001454/0.08325, allocations: 117.7 kB / 0.4995 GB, free: 296 kB / 366.1 MB
Notification: Performance of [SIM] Detect States: time 0.0003397/0.08359, allocations: 263.6 kB / 0.4998 GB, free: 15.98 MB / 382.1 MB
Notification: Performance of [SIM] Events: time 0.0001652/0.08375, allocations: 94.45 kB / 0.4998 GB, free: 15.88 MB / 382.1 MB
Notification: Performance of [SIM] Partitioning: time 0.0003861/0.08414, allocations: 331.4 kB / 0.5002 GB, free: 15.54 MB / 382.1 MB
Notification: Performance of [SIM] Causalize: time 0.0007878/0.08492, allocations: 0.5722 MB / 0.5007 GB, free: 14.95 MB / 382.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0005638/0.08549, allocations: 0.6086 MB / 0.5013 GB, free: 14.34 MB / 382.1 MB
Notification: Performance of [INI] Simplify: time 0.0009343/0.08642, allocations: 0.6669 MB / 0.502 GB, free: 13.6 MB / 382.1 MB
Notification: Performance of [INI] Inline: time 0.001054/0.08748, allocations: 1.12 MB / 0.5031 GB, free: 12.48 MB / 382.1 MB
Notification: Performance of [INI] Partitioning: time 5.85e-05/0.08754, allocations: 36 kB / 0.5031 GB, free: 12.43 MB / 382.1 MB
Notification: Performance of [INI] Cleanup: time 0.0002413/0.08778, allocations: 271.7 kB / 0.5034 GB, free: 12.16 MB / 382.1 MB
Notification: Performance of [INI] Causalize: time 0.00328/0.09106, allocations: 2.45 MB / 0.5057 GB, free: 9.691 MB / 382.1 MB
Notification: Performance of [INI] Tearing: time 0.0002881/0.09134, allocations: 239.8 kB / 0.506 GB, free: 9.457 MB / 382.1 MB
Notification: Performance of [SIM] Initialization: time 1.002e-06/0.09135, allocations: 0 / 0.506 GB, free: 9.457 MB / 382.1 MB
Notification: Performance of [SIM] Remove Dummies: time 7.734e-06/0.09135, allocations: 288 / 0.506 GB, free: 9.457 MB / 382.1 MB
Notification: Performance of [SIM] Tearing: time 0.0001302/0.09148, allocations: 99.91 kB / 0.5061 GB, free: 9.359 MB / 382.1 MB
Notification: Performance of [SIM] Categorize: time 1.476e-05/0.0915, allocations: 11.94 kB / 0.5061 GB, free: 9.348 MB / 382.1 MB
Notification: Performance of [SIM] Solve: time 0.000854/0.09235, allocations: 0.5654 MB / 0.5066 GB, free: 8.781 MB / 382.1 MB
Notification: Performance of [SIM] Jacobian: time 0.002016/0.09437, allocations: 1.782 MB / 0.5084 GB, free: 6.891 MB / 382.1 MB
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: ......... 1
 * 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: ............................. 7 (7) {PI_w_control.xfb, PI_w_control.xBias, PI_w_control.u, PI_w_control.csfil, PI_enforce_p_limit.add1.u2, v_pos.y, load_pos.y}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 11 (11) {PI_w_control.HIsat, PI_w_control.LOsat, $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: ........... 33 (scalar:33, 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: ... 1 (linear: 1, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 80 (scalar:80, 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: ... 1 (linear: 1, nonlinear:0)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 80 (scalar:80, 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: ... 1 (linear: 1, nonlinear:0)
Notification: Performance of backend: time 8.327e-05/0.09445, allocations: 48.78 kB / 0.5084 GB, free: 6.844 MB / 382.1 MB
Notification: Performance of SimCode: time 0.002145/0.0966, allocations: 1.725 MB / 0.5101 GB, free: 5.082 MB / 382.1 MB
Notification: Performance of Templates: time 0.008932/0.1055, allocations: 4.02 MB / 0.514 GB, free: 1.082 MB / 382.1 MB
"
[Timeout remaining time 660]
make -j1 -f AES_AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control.makefile [Timeout 660]
(rm -f AES_AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control.pipe ; mkfifo AES_AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control.pipe ; head -c 1048576 < AES_AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control.pipe >> ../files/AES_AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control.sim & ./AES_AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control  -lv=LOG_STDOUT,LOG_ASSERT,LOG_STATS -s=dassl -variableFilter=.* -abortSlowSimulation -alarm=480 -lv LOG_STATS > AES_AES.Coursework.ThermSys_control_problems.Keep_limits_and_overrides.Override_control.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 4.53926401771605]
Failed to read output from testmodel.py, exit status != 0:
0.28741571493446827 0.297492179 0.22009323700000002
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f5055882f20>