Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr TILMedia_TILMedia.Testers.TestGas.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.01158/0.01158, allocations: 1.754 MB / 20.61 MB, free: 1.004 MB / 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 1.187/1.187, allocations: 130.7 MB / 154.8 MB, free: 4.266 MB / 126.1 MB
"
[Timeout remaining time 179]
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.00196/0.00196, allocations: 110.2 kB / 186.5 MB, free: 2.086 MB / 142.1 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.002217/0.002217, allocations: 212.8 kB / 218.4 MB, free: 2.246 MB / 174.1 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 2.124/2.124, allocations: 230.6 MB / 480.7 MB, free: 92 kB / 318.1 MB
"
[Timeout remaining time 178]
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.1637/0.1637, allocations: 25.6 MB / 0.5774 GB, free: 2.082 MB / 430.1 MB
"
[Timeout remaining time 179]
Using package TILMedia with version 1.9.0 ClaRa (/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 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 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: "" <> buildModelFMU(TILMedia.Testers.TestGas,fileNamePrefix="TILMedia_TILMedia_Testers_TestGas",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(TILMedia.Testers.TestGas,fileNamePrefix="TILMedia_TILMedia_Testers_TestGas",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: SMArtInt requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: ClaRa requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Warning: Requested package SMArtInt of version 0.5.1, but this package was already loaded with version 0.3.1. There are no conversion annotations for this version but 0.5.1 is newer than 0.3.1. There is a possibility that 0.3.1 remains backwards compatible, but it is not loaded so OpenModelica cannot verify this.
Notification: TILMedia requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.004223/0.004223, allocations: 140.5 kB / 0.7695 GB, free: 7.969 MB / 0.5607 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.9897/0.994, allocations: 89.26 MB / 0.8567 GB, free: 29.62 MB / 0.5763 GB
Notification: Performance of NFInst.instantiate(TILMedia.Testers.TestGas): time 0.006485/1, allocations: 2.616 MB / 0.8593 GB, free: 27.84 MB / 0.5763 GB
Notification: Performance of NFInst.instExpressions: time 0.02257/1.023, allocations: 10.55 MB / 0.8696 GB, free: 20.79 MB / 0.5763 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0006955/1.024, allocations: 3.562 kB / 0.8696 GB, free: 20.79 MB / 0.5763 GB
Notification: Performance of NFTyping.typeComponents: time 0.001866/1.026, allocations: 237.7 kB / 0.8698 GB, free: 20.68 MB / 0.5763 GB
Notification: Performance of NFTyping.typeBindings: time 0.0009602/1.027, allocations: 264.2 kB / 0.87 GB, free: 20.53 MB / 0.5763 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01269/1.039, allocations: 2.462 MB / 0.8724 GB, free: 19.29 MB / 0.5763 GB
Notification: Performance of NFFlatten.flatten: time 0.002763/1.042, allocations: 0.9986 MB / 0.8734 GB, free: 18.87 MB / 0.5763 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0001984/1.042, allocations: 27.38 kB / 0.8734 GB, free: 18.85 MB / 0.5763 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001422/1.044, allocations: 360.3 kB / 0.8738 GB, free: 18.71 MB / 0.5763 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003047/1.047, allocations: 1.245 MB / 0.875 GB, free: 18.3 MB / 0.5763 GB
Notification: Performance of NFPackage.collectConstants: time 0.001415/1.048, allocations: 275.3 kB / 0.8753 GB, free: 18.3 MB / 0.5763 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01249/1.061, allocations: 2.802 MB / 0.878 GB, free: 17.05 MB / 0.5763 GB
Notification: Performance of NFScalarize.scalarize: time 0.001955/1.063, allocations: 0.8618 MB / 0.8788 GB, free: 16.42 MB / 0.5763 GB
Notification: Performance of NFVerifyModel.verify: time 0.001598/1.064, allocations: 0.8244 MB / 0.8797 GB, free: 15.82 MB / 0.5763 GB
Notification: Performance of NFConvertDAE.convert: time 0.01898/1.083, allocations: 4.799 MB / 0.8843 GB, free: 13.06 MB / 0.5763 GB
Notification: Performance of FrontEnd - DAE generated: time 6.923e-06/1.083, allocations: 1.375 kB / 0.8843 GB, free: 13.06 MB / 0.5763 GB
Notification: Performance of FrontEnd: time 1.894e-06/1.083, allocations: 0 / 0.8843 GB, free: 13.06 MB / 0.5763 GB
Notification: Performance of Transformations before backend: time 0.0001512/1.083, allocations: 0 / 0.8843 GB, free: 13.06 MB / 0.5763 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 245
 * Number of variables: 245
Notification: Performance of Generate backend data structure: time 0.01915/1.102, allocations: 3.232 MB / 0.8875 GB, free: 11.13 MB / 0.5763 GB
Notification: Performance of prepare preOptimizeDAE: time 9.845e-05/1.103, allocations: 12.59 kB / 0.8875 GB, free: 11.13 MB / 0.5763 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0005019/1.103, allocations: 137.8 kB / 0.8876 GB, free: 11.02 MB / 0.5763 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00141/1.104, allocations: 128.2 kB / 0.8878 GB, free: 10.94 MB / 0.5763 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006345/1.111, allocations: 2.178 MB / 0.8899 GB, free: 9.539 MB / 0.5763 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.366e-05/1.111, allocations: 44.08 kB / 0.8899 GB, free: 9.516 MB / 0.5763 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002394/1.111, allocations: 52.59 kB / 0.89 GB, free: 9.5 MB / 0.5763 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01321/1.124, allocations: 4.271 MB / 0.8942 GB, free: 7.445 MB / 0.5763 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.476e-05/1.124, allocations: 7.922 kB / 0.8942 GB, free: 7.438 MB / 0.5763 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002045/1.125, allocations: 27.38 kB / 0.8942 GB, free: 7.418 MB / 0.5763 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002874/1.125, allocations: 129.1 kB / 0.8943 GB, free: 7.387 MB / 0.5763 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02313/1.148, allocations: 12.47 MB / 0.9065 GB, free: 13.86 MB / 0.5919 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.027/1.175, allocations: 8.141 MB / 0.9144 GB, free: 5.621 MB / 0.5919 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.007387/1.182, allocations: 1.253 MB / 0.9157 GB, free: 4.359 MB / 0.5919 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001183/1.184, allocations: 388.6 kB / 0.916 GB, free: 3.977 MB / 0.5919 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0006852/1.184, allocations: 141 kB / 0.9162 GB, free: 3.84 MB / 0.5919 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.452e-05/1.184, allocations: 51.81 kB / 0.9162 GB, free: 3.777 MB / 0.5919 GB
Notification: Performance of pre-optimization done (n=142): time 7.013e-06/1.184, allocations: 3.938 kB / 0.9162 GB, free: 3.773 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=142): time 0.01489/1.199, allocations: 2.391 MB / 0.9186 GB, free: 1.379 MB / 0.5919 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001246/1.199, allocations: 68.72 kB / 0.9186 GB, free: 1.301 MB / 0.5919 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005957/1.205, allocations: 1.674 MB / 0.9203 GB, free: 15.6 MB / 0.6075 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002442/1.206, allocations: 45.7 kB / 0.9203 GB, free: 15.55 MB / 0.6075 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0009487/1.207, allocations: 0.5666 MB / 0.9209 GB, free: 14.98 MB / 0.6075 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001062/1.208, allocations: 0.5035 MB / 0.9213 GB, free: 14.47 MB / 0.6075 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002228/1.21, allocations: 459.3 kB / 0.9218 GB, free: 14.02 MB / 0.6075 GB
Notification: Performance of setup shared object (initialization): time 0.0003377/1.21, allocations: 353.9 kB / 0.9221 GB, free: 13.66 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002182/1.212, allocations: 0.8041 MB / 0.9229 GB, free: 12.86 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003246/1.216, allocations: 1.481 MB / 0.9243 GB, free: 11.07 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004543/1.22, allocations: 2.116 MB / 0.9264 GB, free: 8.656 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.028e-05/1.22, allocations: 11.94 kB / 0.9264 GB, free: 8.645 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=239) (initialization): time 0.006921/1.227, allocations: 2.554 MB / 0.9289 GB, free: 6.082 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 6.303e-05/1.227, allocations: 16 kB / 0.9289 GB, free: 6.066 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.227e-05/1.227, allocations: 24 kB / 0.929 GB, free: 6.043 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001056/1.227, allocations: 32 kB / 0.929 GB, free: 6.012 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002413/1.23, allocations: 0.5154 MB / 0.9295 GB, free: 5.496 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 9.754e-05/1.23, allocations: 47.86 kB / 0.9295 GB, free: 5.449 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003209/1.233, allocations: 226.5 kB / 0.9298 GB, free: 5.227 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0006643/1.234, allocations: 244 kB / 0.93 GB, free: 4.988 MB / 0.6075 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 98
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (239):
 * Single equations (assignments): 239
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.001528/1.235, allocations: 448.9 kB / 0.9304 GB, free: 4.539 MB / 0.6075 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008522/1.236, allocations: 135.1 kB / 0.9305 GB, free: 4.406 MB / 0.6075 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006329/1.242, allocations: 2.176 MB / 0.9327 GB, free: 2.219 MB / 0.6075 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.769e-05/1.242, allocations: 16 kB / 0.9327 GB, free: 2.203 MB / 0.6075 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.603e-05/1.242, allocations: 0 / 0.9327 GB, free: 2.203 MB / 0.6075 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.19e-05/1.242, allocations: 7.969 kB / 0.9327 GB, free: 2.195 MB / 0.6075 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002866/1.245, allocations: 0.8299 MB / 0.9335 GB, free: 1.324 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.548e-05/1.245, allocations: 0 / 0.9335 GB, free: 1.324 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001056/1.246, allocations: 327.6 kB / 0.9338 GB, free: 1.004 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (simulation): time 3.916e-05/1.246, allocations: 4 kB / 0.9338 GB, free: 1 MB / 0.6075 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002213/1.247, allocations: 83.95 kB / 0.9339 GB, free: 0.918 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.923e-05/1.247, allocations: 4 kB / 0.9339 GB, free: 0.9141 MB / 0.6075 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.006e-06/1.247, allocations: 4 kB / 0.9339 GB, free: 0.9102 MB / 0.6075 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003626/1.25, allocations: 1.311 MB / 0.9352 GB, free: 15.58 MB / 0.6232 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001694/1.252, allocations: 386.6 kB / 0.9356 GB, free: 15.2 MB / 0.6232 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005912/1.253, allocations: 28 kB / 0.9356 GB, free: 15.17 MB / 0.6232 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001267/1.254, allocations: 27.98 kB / 0.9356 GB, free: 15.14 MB / 0.6232 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002863/1.254, allocations: 137.1 kB / 0.9357 GB, free: 15.01 MB / 0.6232 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004406/1.255, allocations: 204 kB / 0.9359 GB, free: 14.81 MB / 0.6232 GB
Notification: Performance of sorting global known variables: time 0.002985/1.258, allocations: 1.161 MB / 0.9371 GB, free: 13.64 MB / 0.6232 GB
Notification: Performance of sort global known variables: time 9e-08/1.258, allocations: 0 / 0.9371 GB, free: 13.64 MB / 0.6232 GB
Notification: Performance of remove unused functions: time 0.004042/1.262, allocations: 0.5577 MB / 0.9376 GB, free: 13.08 MB / 0.6232 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (142):
 * Single equations (assignments): 142
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.007935/1.27, allocations: 2.697 MB / 0.9402 GB, free: 10.57 MB / 0.6232 GB
Notification: Performance of simCode: created initialization part: time 0.004294/1.274, allocations: 1.593 MB / 0.9418 GB, free: 8.977 MB / 0.6232 GB
Notification: Performance of simCode: created event and clocks part: time 8.036e-06/1.274, allocations: 192 / 0.9418 GB, free: 8.977 MB / 0.6232 GB
Notification: Performance of simCode: created simulation system equations: time 0.001239/1.275, allocations: 0.5383 MB / 0.9423 GB, free: 8.441 MB / 0.6232 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002574/1.278, allocations: 255.2 kB / 0.9426 GB, free: 8.191 MB / 0.6232 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03625/1.314, allocations: 13.38 MB / 0.9556 GB, free: 10.05 MB / 0.6388 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001284/1.315, allocations: 0.5489 MB / 0.9562 GB, free: 9.473 MB / 0.6388 GB
Notification: Performance of simCode: alias equations: time 0.005188/1.32, allocations: 1.294 MB / 0.9574 GB, free: 8.172 MB / 0.6388 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002/1.322, allocations: 0.6083 MB / 0.958 GB, free: 7.562 MB / 0.6388 GB
Notification: Performance of SimCode: time 2.805e-06/1.322, allocations: 0 / 0.958 GB, free: 7.562 MB / 0.6388 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1197/1.442, allocations: 36.57 MB / 0.9937 GB, free: 3.113 MB / 0.67 GB
Notification: Performance of buildModelFMU: Generate platform static: time 15.42/16.86, allocations: 4.578 kB / 0.9937 GB, free: 3.109 MB / 0.67 GB
"
[Timeout remaining time 643]
(rm -f TILMedia_TILMedia.Testers.TestGas.pipe ; mkfifo TILMedia_TILMedia.Testers.TestGas.pipe ; head -c 1048576 < TILMedia_TILMedia.Testers.TestGas.pipe >> ../files/TILMedia_TILMedia.Testers.TestGas.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_TILMedia_TILMedia_Testers_TestGas_fmu --startTime=0 --stopTime=1 --stepSize=0.002 --timeout=50 --tolerance=1e-06 TILMedia_TILMedia_Testers_TestGas.fmu > TILMedia_TILMedia.Testers.TestGas.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 23.62035174202174]
Failed to read output from testmodel.py, exit status != 0:
17.25424124766141 17.281952233 16.192710173
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f642ea96fb0>