Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr TILMedia_TILMedia.Testers.TestGas_moistAir.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtIInt 0.1.1-Release_Dymola_2023x_Refresh_1/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtIInt 0.1.1-Release_Dymola_2023x_Refresh_1/package.mo): time 0.00833/0.00833, allocations: 1.423 MB / 17.77 MB, free: 4.855 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.8.2-main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.8.2-main/package.mo): time 0.903/0.903, allocations: 129 MB / 149.8 MB, free: 12.05 MB / 126.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001257/0.001257, allocations: 105.3 kB / 180.7 MB, free: 3.723 MB / 142.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00149/0.00149, allocations: 196.3 kB / 211.8 MB, free: 9.973 MB / 174.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.581/1.581, allocations: 225.6 MB / 468.2 MB, free: 12.22 MB / 318.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 1.8.2-main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 1.8.2-main/package.mo): time 0.1072/0.1072, allocations: 23.17 MB / 0.5609 GB, free: 5.84 MB / 414.1 MB
"
[Timeout remaining time 180]
Using package TILMedia with version 1.8.2 ClaRa (/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 1.8.2-main/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Using package ClaRa with version 1.8.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.8.2-main/package.mo)
Using package SMArtIInt with version 0.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtIInt 0.1.1-Release_Dymola_2023x_Refresh_1/package.mo)
Running command: "" <> buildModelFMU(TILMedia.Testers.TestGas_moistAir,fileNamePrefix="TILMedia_TILMedia_Testers_TestGas_moistAir",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(TILMedia.Testers.TestGas_moistAir,fileNamePrefix="TILMedia_TILMedia_Testers_TestGas_moistAir",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Warning: Requested package SMArtIInt of version 0.2.2, but this package was already loaded with version 0.1.1. There are no conversion annotations for this version but 0.2.2 is newer than 0.1.1. There is a possibility that 0.1.1 remains backwards compatible, but it is not loaded so OpenModelica cannot verify this.
Notification: Performance of FrontEnd - loaded program: time 0.003986/0.003986, allocations: 135.8 kB / 0.7465 GB, free: 4.707 MB / 478.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5082/0.5122, allocations: 86.82 MB / 0.8313 GB, free: 4.766 MB / 0.5294 GB
Notification: Performance of NFInst.instantiate(TILMedia.Testers.TestGas_moistAir): time 0.003349/0.5156, allocations: 2.379 MB / 0.8336 GB, free: 3.09 MB / 0.5294 GB
Notification: Performance of NFInst.instExpressions: time 0.005338/0.5209, allocations: 4.322 MB / 0.8378 GB, free: 64 kB / 0.5294 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002079/0.5211, allocations: 1.469 kB / 0.8378 GB, free: 64 kB / 0.5294 GB
Notification: Performance of NFTyping.typeComponents: time 0.0009081/0.522, allocations: 207.5 kB / 0.838 GB, free: 15.96 MB / 0.545 GB
Notification: Performance of NFTyping.typeBindings: time 0.0004483/0.5225, allocations: 178.6 kB / 0.8382 GB, free: 15.86 MB / 0.545 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001818/0.5243, allocations: 0.6815 MB / 0.8389 GB, free: 15.49 MB / 0.545 GB
Notification: Performance of NFFlatten.flatten: time 0.0008543/0.5252, allocations: 0.5824 MB / 0.8394 GB, free: 15.25 MB / 0.545 GB
Notification: Performance of NFFlatten.resolveConnections: time 6.24e-05/0.5252, allocations: 19.3 kB / 0.8395 GB, free: 15.24 MB / 0.545 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0002527/0.5255, allocations: 195.3 kB / 0.8397 GB, free: 15.16 MB / 0.545 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.000921/0.5264, allocations: 0.7862 MB / 0.8404 GB, free: 14.72 MB / 0.545 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002631/0.5267, allocations: 173.8 kB / 0.8406 GB, free: 14.72 MB / 0.545 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002659/0.5293, allocations: 1.41 MB / 0.842 GB, free: 14.03 MB / 0.545 GB
Notification: Performance of NFScalarize.scalarize: time 0.0006548/0.53, allocations: 0.583 MB / 0.8425 GB, free: 13.61 MB / 0.545 GB
Notification: Performance of NFVerifyModel.verify: time 0.0007866/0.5308, allocations: 0.6154 MB / 0.8431 GB, free: 13.14 MB / 0.545 GB
Notification: Performance of NFConvertDAE.convert: time 0.004229/0.535, allocations: 2.386 MB / 0.8455 GB, free: 11.72 MB / 0.545 GB
Notification: Performance of FrontEnd - DAE generated: time 5.38e-06/0.535, allocations: 0.75 kB / 0.8455 GB, free: 11.72 MB / 0.545 GB
Notification: Performance of FrontEnd: time 2.415e-06/0.535, allocations: 0 / 0.8455 GB, free: 11.72 MB / 0.545 GB
Notification: Performance of Transformations before backend: time 2.537e-05/0.535, allocations: 0.625 kB / 0.8455 GB, free: 11.72 MB / 0.545 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 182
 * Number of variables: 182
Notification: Performance of Generate backend data structure: time 0.005873/0.5409, allocations: 2.1 MB / 0.8475 GB, free: 10.39 MB / 0.545 GB
Notification: Performance of prepare preOptimizeDAE: time 5.171e-05/0.5409, allocations: 9.344 kB / 0.8475 GB, free: 10.39 MB / 0.545 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0002245/0.5412, allocations: 102.6 kB / 0.8476 GB, free: 10.3 MB / 0.545 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0003782/0.5415, allocations: 84.83 kB / 0.8477 GB, free: 10.25 MB / 0.545 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003262/0.5448, allocations: 1.455 MB / 0.8491 GB, free: 9.273 MB / 0.545 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.394e-05/0.5448, allocations: 27.62 kB / 0.8492 GB, free: 9.258 MB / 0.545 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001292/0.545, allocations: 38.56 kB / 0.8492 GB, free: 9.242 MB / 0.545 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002744/0.5477, allocations: 1.674 MB / 0.8508 GB, free: 8.293 MB / 0.545 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.743e-05/0.5477, allocations: 5.031 kB / 0.8508 GB, free: 8.289 MB / 0.545 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.774e-05/0.5478, allocations: 15.41 kB / 0.8508 GB, free: 8.277 MB / 0.545 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.809e-05/0.5479, allocations: 35.98 kB / 0.8509 GB, free: 8.273 MB / 0.545 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004125/0.552, allocations: 2.59 MB / 0.8534 GB, free: 7.152 MB / 0.545 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.009712/0.5617, allocations: 5.16 MB / 0.8584 GB, free: 3.672 MB / 0.545 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009743/0.5627, allocations: 0.6465 MB / 0.8591 GB, free: 3.348 MB / 0.545 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007849/0.5635, allocations: 0.5779 MB / 0.8596 GB, free: 3.062 MB / 0.545 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001149/0.5636, allocations: 17.53 kB / 0.8597 GB, free: 3.055 MB / 0.545 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.836e-05/0.5637, allocations: 44.78 kB / 0.8597 GB, free: 3.004 MB / 0.545 GB
Notification: Performance of pre-optimization done (n=114): time 2.956e-06/0.5637, allocations: 0 / 0.8597 GB, free: 3.004 MB / 0.545 GB
Notification: Performance of matching and sorting (n=114): time 0.002957/0.5666, allocations: 2.057 MB / 0.8617 GB, free: 2.012 MB / 0.545 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.493e-05/0.5667, allocations: 54.91 kB / 0.8618 GB, free: 1.949 MB / 0.545 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0009202/0.5676, allocations: 0.6826 MB / 0.8624 GB, free: 1.566 MB / 0.545 GB
Notification: Performance of collectPreVariables (initialization): time 5.95e-05/0.5676, allocations: 31.08 kB / 0.8625 GB, free: 1.531 MB / 0.545 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002903/0.5679, allocations: 358.1 kB / 0.8628 GB, free: 1.211 MB / 0.545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003473/0.5683, allocations: 392.1 kB / 0.8632 GB, free: 0.8672 MB / 0.545 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003012/0.5686, allocations: 169.9 kB / 0.8633 GB, free: 0.7812 MB / 0.545 GB
Notification: Performance of setup shared object (initialization): time 0.0002276/0.5688, allocations: 397.2 kB / 0.8637 GB, free: 416 kB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008608/0.5697, allocations: 0.646 MB / 0.8643 GB, free: 96 kB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001168/0.5708, allocations: 0.9255 MB / 0.8652 GB, free: 15.41 MB / 0.5607 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0021/0.5729, allocations: 1.666 MB / 0.8669 GB, free: 14.36 MB / 0.5607 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.012e-05/0.5729, allocations: 5.766 kB / 0.8669 GB, free: 14.36 MB / 0.5607 GB
Notification: Performance of matching and sorting (n=152) (initialization): time 0.00251/0.5755, allocations: 1.699 MB / 0.8685 GB, free: 13.52 MB / 0.5607 GB
Notification: Performance of prepare postOptimizeDAE: time 2.196e-05/0.5755, allocations: 10.62 kB / 0.8685 GB, free: 13.52 MB / 0.5607 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.054e-05/0.5755, allocations: 25.98 kB / 0.8686 GB, free: 13.52 MB / 0.5607 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.443e-05/0.5756, allocations: 20.16 kB / 0.8686 GB, free: 13.51 MB / 0.5607 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001784/0.5773, allocations: 227.9 kB / 0.8688 GB, free: 13.45 MB / 0.5607 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0004808/0.5778, allocations: 0.6005 MB / 0.8694 GB, free: 12.86 MB / 0.5607 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007945/0.5786, allocations: 108.2 kB / 0.8695 GB, free: 12.78 MB / 0.5607 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001083/0.5787, allocations: 52.83 kB / 0.8696 GB, free: 12.77 MB / 0.5607 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 39
 * 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 (76):
 * Single equations (assignments): 69
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 6
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0005283/0.5793, allocations: 306.1 kB / 0.8698 GB, free: 12.51 MB / 0.5607 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001665/0.5794, allocations: 75.44 kB / 0.8699 GB, free: 12.43 MB / 0.5607 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0003708/0.5798, allocations: 140.3 kB / 0.87 GB, free: 12.3 MB / 0.5607 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.726e-06/0.5798, allocations: 8 kB / 0.8701 GB, free: 12.29 MB / 0.5607 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.171e-05/0.5798, allocations: 3.938 kB / 0.8701 GB, free: 12.29 MB / 0.5607 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.983e-06/0.5798, allocations: 3.984 kB / 0.8701 GB, free: 12.28 MB / 0.5607 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001401/0.5812, allocations: 1.005 MB / 0.871 GB, free: 11.22 MB / 0.5607 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.498e-05/0.5813, allocations: 15.98 kB / 0.8711 GB, free: 11.21 MB / 0.5607 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00154/0.5828, allocations: 163.8 kB / 0.8712 GB, free: 11.05 MB / 0.5607 GB
Notification: Performance of postOpt tearingSystem (simulation): time 8.255e-06/0.5828, allocations: 4 kB / 0.8712 GB, free: 11.04 MB / 0.5607 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.586e-05/0.5829, allocations: 12 kB / 0.8712 GB, free: 11.03 MB / 0.5607 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0004366/0.5833, allocations: 0.5899 MB / 0.8718 GB, free: 10.42 MB / 0.5607 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.623e-06/0.5833, allocations: 0 / 0.8718 GB, free: 10.42 MB / 0.5607 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002154/0.5855, allocations: 1.521 MB / 0.8733 GB, free: 8.883 MB / 0.5607 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000613/0.5861, allocations: 260.3 kB / 0.8735 GB, free: 8.609 MB / 0.5607 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001142/0.5862, allocations: 8 kB / 0.8735 GB, free: 8.602 MB / 0.5607 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004008/0.5866, allocations: 11.98 kB / 0.8736 GB, free: 8.59 MB / 0.5607 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001025/0.5867, allocations: 31.91 kB / 0.8736 GB, free: 8.559 MB / 0.5607 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.718e-05/0.5868, allocations: 31.98 kB / 0.8736 GB, free: 8.527 MB / 0.5607 GB
Notification: Performance of sorting global known variables: time 0.0006443/0.5874, allocations: 494.8 kB / 0.8741 GB, free: 8.047 MB / 0.5607 GB
Notification: Performance of sort global known variables: time 1.1e-07/0.5874, allocations: 4 kB / 0.8741 GB, free: 8.043 MB / 0.5607 GB
Notification: Performance of remove unused functions: time 0.001182/0.5886, allocations: 323.3 kB / 0.8744 GB, free: 7.727 MB / 0.5607 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 (38):
 * Single equations (assignments): 31
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 6
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.003819/0.5924, allocations: 2.545 MB / 0.8769 GB, free: 5.273 MB / 0.5607 GB
Notification: Performance of simCode: created initialization part: time 0.00253/0.5949, allocations: 1.663 MB / 0.8785 GB, free: 3.574 MB / 0.5607 GB
Notification: Performance of simCode: created event and clocks part: time 3.687e-06/0.5949, allocations: 3.938 kB / 0.8785 GB, free: 3.57 MB / 0.5607 GB
Notification: Performance of simCode: created simulation system equations: time 0.001138/0.5961, allocations: 0.8698 MB / 0.8794 GB, free: 2.664 MB / 0.5607 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00108/0.5972, allocations: 214.6 kB / 0.8796 GB, free: 2.449 MB / 0.5607 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01495/0.6121, allocations: 9.981 MB / 0.8893 GB, free: 8.113 MB / 0.5763 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007328/0.6128, allocations: 1.009 MB / 0.8903 GB, free: 7.074 MB / 0.5763 GB
Notification: Performance of simCode: alias equations: time 0.0009126/0.6138, allocations: 292.9 kB / 0.8906 GB, free: 6.789 MB / 0.5763 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005233/0.6143, allocations: 275.3 kB / 0.8908 GB, free: 6.52 MB / 0.5763 GB
Notification: Performance of SimCode: time 1.153e-06/0.6143, allocations: 0 / 0.8908 GB, free: 6.52 MB / 0.5763 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.055/0.6693, allocations: 23.08 MB / 0.9134 GB, free: 15.63 MB / 0.6075 GB
Notification: Performance of buildModelFMU: Generate platform static: time 13.15/13.82, allocations: 15.92 kB / 0.9134 GB, free: 15.62 MB / 0.6075 GB
"
[Timeout remaining time 646]
(rm -f TILMedia_TILMedia.Testers.TestGas_moistAir.pipe ; mkfifo TILMedia_TILMedia.Testers.TestGas_moistAir.pipe ; head -c 1048576 < TILMedia_TILMedia.Testers.TestGas_moistAir.pipe >> ../files/TILMedia_TILMedia.Testers.TestGas_moistAir.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_TILMedia_TILMedia_Testers_TestGas_moistAir_fmu --startTime=0 --stopTime=1 --stepSize=0.0004 --timeout=50 --tolerance=1e-06 TILMedia_TILMedia_Testers_TestGas_moistAir.fmu > TILMedia_TILMedia.Testers.TestGas_moistAir.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 18.309061823878437]
Failed to read output from testmodel.py, exit status != 0:
14.17985970992595 14.19539818 13.657225066
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fabc8122020>