Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AES_AES.Devel_test_models.Test_HP_001.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.001326/0.001326, 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.00142/0.00142, allocations: 208.3 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.481/1.481, allocations: 230.7 MB / 256.9 MB, free: 7.758 MB / 206.1 MB
"
[Timeout remaining time 178]
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.102/0.102, allocations: 24.03 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)
Running command: translateModel(AES.Devel_test_models.Test_HP_001,tolerance=1e-06,outputFormat="empty",numberOfIntervals=10000,variableFilter="",fileNamePrefix="AES_AES.Devel_test_models.Test_HP_001")
translateModel(AES.Devel_test_models.Test_HP_001,tolerance=1e-06,outputFormat="empty",numberOfIntervals=10000,variableFilter="",fileNamePrefix="AES_AES.Devel_test_models.Test_HP_001") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.353e-05/2.353e-05, allocations: 2.281 kB / 474.4 MB, free: 5.879 MB / 334.1 MB
Notification: Performance of NFInst.instantiate(AES.Devel_test_models.Test_HP_001): time 0.003642/0.003666, allocations: 1.681 MB / 476.1 MB, free: 4.188 MB / 334.1 MB
Notification: Performance of NFInst.instExpressions: time 0.0002374/0.003903, allocations: 71.73 kB / 476.1 MB, free: 4.117 MB / 334.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 5.411e-05/0.003957, allocations: 4 kB / 476.1 MB, free: 4.113 MB / 334.1 MB
Notification: Performance of NFTyping.typeComponents: time 4.946e-05/0.004007, allocations: 7.875 kB / 476.2 MB, free: 4.105 MB / 334.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0001425/0.004149, allocations: 23.78 kB / 476.2 MB, free: 4.082 MB / 334.1 MB
Notification: Performance of NFTyping.typeClassSections: time 7.971e-05/0.004229, allocations: 15.97 kB / 476.2 MB, free: 4.066 MB / 334.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0001933/0.004422, allocations: 95.64 kB / 476.3 MB, free: 3.973 MB / 334.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0001792/0.004601, allocations: 24.2 kB / 476.3 MB, free: 3.945 MB / 334.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 7.032e-05/0.004672, allocations: 31.86 kB / 476.3 MB, free: 3.914 MB / 334.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 9.535e-05/0.004767, allocations: 31.84 kB / 476.4 MB, free: 3.883 MB / 334.1 MB
Notification: Performance of NFPackage.collectConstants: time 2.407e-05/0.004791, allocations: 8 kB / 476.4 MB, free: 3.875 MB / 334.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 1.844e-05/0.00481, allocations: 4 kB / 476.4 MB, free: 3.871 MB / 334.1 MB
Notification: Performance of combineBinaries: time 0.0001575/0.004967, allocations: 150.5 kB / 476.5 MB, free: 3.723 MB / 334.1 MB
Notification: Performance of replaceArrayConstructors: time 6.971e-05/0.005037, allocations: 94.78 kB / 476.6 MB, free: 3.629 MB / 334.1 MB
Notification: Performance of NFVerifyModel.verify: time 3.123e-05/0.005068, allocations: 12 kB / 476.6 MB, free: 3.617 MB / 334.1 MB
Notification: Performance of FrontEnd: time 1.601e-05/0.005084, allocations: 4 kB / 476.6 MB, free: 3.613 MB / 334.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 22 (22)
 * Number of variables: 22 (22)
Notification: Performance of [SIM] Bindings: time 0.0007664/0.00585, allocations: 498.8 kB / 477.1 MB, free: 3.004 MB / 334.1 MB
Notification: Performance of [SIM] FunctionAlias: time 8.588e-05/0.005936, allocations: 56 kB / 477.2 MB, free: 2.938 MB / 334.1 MB
Notification: Performance of [SIM] Early Inline: time 0.0002451/0.006181, allocations: 228.1 kB / 477.4 MB, free: 2.688 MB / 334.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0001472/0.006329, allocations: 88.64 kB / 477.5 MB, free: 2.555 MB / 334.1 MB
Notification: Performance of [SIM] Alias: time 0.001027/0.007355, allocations: 0.4898 MB / 478 MB, free: 1.973 MB / 334.1 MB
Notification: Performance of [SIM] Simplify 2: time 9.819e-05/0.007454, allocations: 76.64 kB / 478.1 MB, free: 1.852 MB / 334.1 MB
Notification: Performance of [SIM] Remove Stream: time 4.898e-05/0.007502, allocations: 40.44 kB / 478.1 MB, free: 1.785 MB / 334.1 MB
Notification: Performance of [SIM] Detect States: time 0.0001359/0.007638, allocations: 88.83 kB / 478.2 MB, free: 1.645 MB / 334.1 MB
Notification: Performance of [SIM] Events: time 2.281e-05/0.007661, allocations: 8 kB / 478.2 MB, free: 1.637 MB / 334.1 MB
Notification: Performance of [SIM] Partitioning: time 0.0001005/0.007762, allocations: 52.09 kB / 478.2 MB, free: 1.578 MB / 334.1 MB
Notification: Performance of [SIM] Causalize: time 0.0001781/0.00794, allocations: 116 kB / 478.4 MB, free: 1.457 MB / 334.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 6.929e-05/0.008009, allocations: 63.89 kB / 478.4 MB, free: 1.395 MB / 334.1 MB
Notification: Performance of [INI] Simplify: time 0.0001821/0.008191, allocations: 125 kB / 478.5 MB, free: 1.203 MB / 334.1 MB
Notification: Performance of [INI] Inline: time 0.0001055/0.008297, allocations: 112 kB / 478.6 MB, free: 1.09 MB / 334.1 MB
Notification: Performance of [INI] Partitioning: time 1.533e-05/0.008312, allocations: 8.125 kB / 478.7 MB, free: 1.074 MB / 334.1 MB
Notification: Performance of [INI] Cleanup: time 2.684e-05/0.008339, allocations: 23.97 kB / 478.7 MB, free: 1.051 MB / 334.1 MB
Notification: Performance of [INI] Causalize: time 0.0002655/0.008604, allocations: 135.9 kB / 478.8 MB, free: 0.9102 MB / 334.1 MB
Notification: Performance of [INI] Tearing: time 1.454e-05/0.008619, allocations: 4 kB / 478.8 MB, free: 0.9062 MB / 334.1 MB
Notification: Performance of [SIM] Initialization: time 3.31e-07/0.008619, allocations: 0 / 478.8 MB, free: 0.9062 MB / 334.1 MB
Notification: Performance of [SIM] DAE-Mode: time 8.694e-05/0.008706, allocations: 48.09 kB / 478.9 MB, free: 0.8516 MB / 334.1 MB
Notification: Performance of [SIM] Remove Dummies: time 5.35e-06/0.008712, allocations: 0 / 478.9 MB, free: 0.8516 MB / 334.1 MB
Notification: Performance of [SIM] Tearing: time 5.681e-06/0.008717, allocations: 8 kB / 478.9 MB, free: 0.8438 MB / 334.1 MB
Notification: Performance of [SIM] Categorize: time 7.404e-06/0.008725, allocations: 4 kB / 478.9 MB, free: 0.8398 MB / 334.1 MB
Notification: Performance of [SIM] Solve: time 0.0001964/0.008921, allocations: 120.2 kB / 479 MB, free: 0.7227 MB / 334.1 MB
Notification: Performance of [SIM] Jacobian: time 0.0001824/0.009104, allocations: 194.9 kB / 479.2 MB, free: 0.5 MB / 334.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 1
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 0
 * 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: ................. 0 (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 4.146e-05/0.009145, allocations: 27.91 kB / 479.2 MB, free: 492 kB / 334.1 MB
Notification: Performance of SimCode: time 0.000504/0.009649, allocations: 312.7 kB / 479.5 MB, free: 160 kB / 334.1 MB
Notification: Performance of Templates: time 0.003033/0.01268, allocations: 0.5364 MB / 480.1 MB, free: 15.62 MB / 350.1 MB
"
[Timeout remaining time 660]
make -j1 -f AES_AES.Devel_test_models.Test_HP_001.makefile [Timeout 660]
(rm -f AES_AES.Devel_test_models.Test_HP_001.pipe ; mkfifo AES_AES.Devel_test_models.Test_HP_001.pipe ; head -c 1048576 < AES_AES.Devel_test_models.Test_HP_001.pipe >> ../files/AES_AES.Devel_test_models.Test_HP_001.sim & ./AES_AES.Devel_test_models.Test_HP_001  -lv=LOG_STATS -s=dassl -abortSlowSimulation -alarm=480 -lv LOG_STATS > AES_AES.Devel_test_models.Test_HP_001.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 4.5690367939532734]
Failed to read output from testmodel.py, exit status != 0:
0.02108387998305261 0.033421012 0.025531116000000003
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fbcfc0eafb0>