Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr TILMedia_AddOn_Tests_TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo): time 0.01168/0.01168, allocations: 1.755 MB / 21.41 MB, free: 392 kB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/package.mo): time 0.8626/0.8626, allocations: 130.8 MB / 155.7 MB, free: 3.75 MB / 126.2 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia main/package.mo): time 0.1132/0.1132, allocations: 25.58 MB / 212.9 MB, free: 8.867 MB / 174.2 MB
"
[Timeout remaining time 180]
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.001311/0.001311, allocations: 107.8 kB / 251.9 MB, free: 27.62 MB / 190.2 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.001791/0.001791, allocations: 210.2 kB / 291.2 MB, free: 5.156 MB / 206.2 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.355/1.355, allocations: 230.6 MB / 0.5477 GB, free: 1.184 MB / 366.2 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia_AddOn_Tests main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia_AddOn_Tests main/package.mo): time 0.004851/0.004851, allocations: 0.715 MB / 0.6386 GB, free: 7.656 MB / 430.2 MB
"
[Timeout remaining time 180]
Using package TILMedia_AddOn_Tests with version 1.9.0 ClaRa (/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia_AddOn_Tests 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)
Using package TILMedia with version 1.9.0 ClaRa (/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia main/package.mo)
Using package ClaRa with version 1.9.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/package.mo)
Using package SMArtInt with version 0.3.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo)
Running command: translateModel(TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue,tolerance=1e-06,outputFormat="empty",numberOfIntervals=50,variableFilter="",fileNamePrefix="TILMedia_AddOn_Tests_TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue")
translateModel(TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue,tolerance=1e-06,outputFormat="empty",numberOfIntervals=50,variableFilter="",fileNamePrefix="TILMedia_AddOn_Tests_TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.483e-05/2.483e-05, allocations: 4.672 kB / 0.8329 GB, free: 53.64 MB / 0.5138 GB
Notification: Performance of NFInst.instantiate(TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue): time 0.001731/0.001755, allocations: 0.7156 MB / 0.8336 GB, free: 52.93 MB / 0.5138 GB
Notification: Performance of NFInst.instExpressions: time 0.001749/0.003504, allocations: 1.773 MB / 0.8354 GB, free: 51.14 MB / 0.5138 GB
Notification: Performance of NFInst.updateImplicitVariability: time 3.764e-05/0.003542, allocations: 0 / 0.8354 GB, free: 51.14 MB / 0.5138 GB
Notification: Performance of NFTyping.typeComponents: time 0.0005637/0.004106, allocations: 131.5 kB / 0.8355 GB, free: 51.01 MB / 0.5138 GB
Notification: Performance of NFTyping.typeBindings: time 0.0001671/0.004273, allocations: 83.7 kB / 0.8356 GB, free: 50.93 MB / 0.5138 GB
Notification: Performance of NFTyping.typeClassSections: time 4.147e-06/0.004277, allocations: 0 / 0.8356 GB, free: 50.93 MB / 0.5138 GB
Notification: Performance of NFFlatten.flatten: time 9.045e-05/0.004367, allocations: 51.89 kB / 0.8356 GB, free: 50.88 MB / 0.5138 GB
Notification: Performance of NFFlatten.resolveConnections: time 4.496e-05/0.004412, allocations: 7.984 kB / 0.8356 GB, free: 50.87 MB / 0.5138 GB
Notification: Performance of NFEvalConstants.evaluate: time 3.026e-05/0.004443, allocations: 15.92 kB / 0.8356 GB, free: 50.85 MB / 0.5138 GB
Notification: Performance of NFSimplifyModel.simplify: time 4.896e-05/0.004492, allocations: 31.78 kB / 0.8357 GB, free: 50.82 MB / 0.5138 GB
Notification: Performance of NFPackage.collectConstants: time 9.738e-06/0.004501, allocations: 4 kB / 0.8357 GB, free: 50.82 MB / 0.5138 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002433/0.006934, allocations: 447.6 kB / 0.8361 GB, free: 50.44 MB / 0.5138 GB
Notification: Performance of combineBinaries: time 7.173e-05/0.007006, allocations: 98.94 kB / 0.8362 GB, free: 50.34 MB / 0.5138 GB
Notification: Performance of replaceArrayConstructors: time 2.971e-05/0.007035, allocations: 71.08 kB / 0.8363 GB, free: 50.27 MB / 0.5138 GB
Notification: Performance of NFVerifyModel.verify: time 9.558e-06/0.007045, allocations: 0 / 0.8363 GB, free: 50.27 MB / 0.5138 GB
Notification: Performance of FrontEnd: time 3.988e-05/0.007085, allocations: 0 / 0.8363 GB, free: 50.27 MB / 0.5138 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1 (1)
 * Number of variables: 1 (1)
Notification: Performance of [SIM] Bindings: time 0.000646/0.007731, allocations: 436.6 kB / 0.8367 GB, free: 49.73 MB / 0.5138 GB
Notification: Performance of [SIM] FunctionAlias: time 4.352e-05/0.007774, allocations: 39.94 kB / 0.8367 GB, free: 49.68 MB / 0.5138 GB
Notification: Performance of [SIM] Early Inline: time 5.302e-05/0.007827, allocations: 56.36 kB / 0.8368 GB, free: 49.59 MB / 0.5138 GB
Notification: Performance of [SIM] Simplify 1: time 3.134e-05/0.007859, allocations: 60.73 kB / 0.8368 GB, free: 49.49 MB / 0.5138 GB
Notification: Performance of [SIM] Alias: time 4.93e-05/0.007908, allocations: 84.59 kB / 0.8369 GB, free: 49.36 MB / 0.5138 GB
Notification: Performance of [SIM] Simplify 2: time 2.456e-05/0.007932, allocations: 60.69 kB / 0.837 GB, free: 49.25 MB / 0.5138 GB
Notification: Performance of [SIM] Remove Stream: time 1.537e-05/0.007948, allocations: 40.42 kB / 0.837 GB, free: 49.18 MB / 0.5138 GB
Notification: Performance of [SIM] Detect States: time 4.291e-05/0.007991, allocations: 72.86 kB / 0.8371 GB, free: 49.06 MB / 0.5138 GB
Notification: Performance of [SIM] Events: time 1.422e-05/0.008005, allocations: 7.859 kB / 0.8371 GB, free: 49.05 MB / 0.5138 GB
Notification: Performance of [SIM] Partitioning: time 6.156e-05/0.008067, allocations: 12.12 kB / 0.8371 GB, free: 49.03 MB / 0.5138 GB
Notification: Performance of [SIM] Causalize: time 0.0001613/0.008228, allocations: 28.11 kB / 0.8371 GB, free: 49 MB / 0.5138 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 4.123e-05/0.008269, allocations: 23.91 kB / 0.8372 GB, free: 48.97 MB / 0.5138 GB
Notification: Performance of [INI] Simplify: time 0.001599/0.009869, allocations: 296.6 kB / 0.8374 GB, free: 48.63 MB / 0.5138 GB
Notification: Performance of [INI] Inline: time 7.521e-05/0.009944, allocations: 68 kB / 0.8375 GB, free: 48.56 MB / 0.5138 GB
Notification: Performance of [INI] Partitioning: time 9.477e-06/0.009953, allocations: 12.12 kB / 0.8375 GB, free: 48.54 MB / 0.5138 GB
Notification: Performance of [INI] Cleanup: time 1.731e-05/0.009971, allocations: 15.98 kB / 0.8375 GB, free: 48.53 MB / 0.5138 GB
Notification: Performance of [INI] Causalize: time 0.0002162/0.01019, allocations: 144.3 kB / 0.8377 GB, free: 48.38 MB / 0.5138 GB
Notification: Performance of [INI] Tearing: time 1.332e-05/0.0102, allocations: 11.94 kB / 0.8377 GB, free: 48.36 MB / 0.5138 GB
Notification: Performance of [SIM] Initialization: time 4.21e-07/0.0102, allocations: 0 / 0.8377 GB, free: 48.36 MB / 0.5138 GB
Notification: Performance of [SIM] Remove Dummies: time 4.588e-06/0.01021, allocations: 7.938 kB / 0.8377 GB, free: 48.36 MB / 0.5138 GB
Notification: Performance of [SIM] Tearing: time 7.71e-07/0.01021, allocations: 0 / 0.8377 GB, free: 48.36 MB / 0.5138 GB
Notification: Performance of [SIM] Categorize: time 6.722e-06/0.01021, allocations: 4 kB / 0.8377 GB, free: 48.35 MB / 0.5138 GB
Notification: Performance of [SIM] Solve: time 0.0001225/0.01034, allocations: 51.95 kB / 0.8377 GB, free: 48.3 MB / 0.5138 GB
Notification: Performance of [SIM] Jacobian: time 8.726e-06/0.01034, allocations: 0 / 0.8377 GB, free: 48.3 MB / 0.5138 GB
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: ........... 1 (scalar:1, 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: ........... 8 (scalar:7, array:1, 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.272e-05/0.01038, allocations: 11.53 kB / 0.8377 GB, free: 48.29 MB / 0.5138 GB
Notification: Performance of SimCode: time 0.001232/0.01161, allocations: 0.605 MB / 0.8383 GB, free: 47.71 MB / 0.5138 GB
Notification: Performance of Templates: time 0.003992/0.0156, allocations: 1.597 MB / 0.8399 GB, free: 46.12 MB / 0.5138 GB
"
[Timeout remaining time 660]
make -j1 -f TILMedia_AddOn_Tests_TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue.makefile [Timeout 660]
(rm -f TILMedia_AddOn_Tests_TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue.pipe ; mkfifo TILMedia_AddOn_Tests_TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue.pipe ; head -c 1048576 < TILMedia_AddOn_Tests_TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue.pipe >> ../files/TILMedia_AddOn_Tests_TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue.sim & ./TILMedia_AddOn_Tests_TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue  -abortSlowSimulation -alarm=480 -lv LOG_STATS > TILMedia_AddOn_Tests_TILMedia_AddOn_Tests.Liquid.LiquidModelDefaultValue.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 6.198307005688548]
Failed to read output from testmodel.py, exit status != 0:
0.02199215069413185 0.032295966 0.023046647
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fbe0fd0ada0>