Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_dev_ClaRa.Components.VolumesValvesFittings.Pipes.Check.OnePhaseFlow.Test_Pipe_L1_TML.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt 0.5.1/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt 0.5.1/package.mo): time 0.009739/0.009739, allocations: 1.765 MB / 20.61 MB, free: 3.863 MB / 13.93 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 1.9.0-ClaRa/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 1.9.0-ClaRa/package.mo): time 0.08146/0.08146, allocations: 25.61 MB / 49.71 MB, free: 2.934 MB / 33.03 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.0009665/0.0009665, allocations: 114.1 kB / 60.65 MB, free: 3.02 MB / 44.04 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.001164/0.001164, allocations: 226.8 kB / 71.73 MB, free: 6.473 MB / 44.04 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 0.9197/0.9197, allocations: 230.6 MB / 313.3 MB, free: 11.75 MB / 234.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0-main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0-main/package.mo): time 0.7319/0.7319, allocations: 130.8 MB / 0.4964 GB, free: 2.355 MB / 362.8 MB
"
[Timeout remaining time 179]
Using package ClaRa with version 1.9.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0-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 1.9.0-ClaRa/package.mo)
Using package SMArtInt with version 0.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt 0.5.1/package.mo)
Running command: setCommandLineOptions("--fmiFlags=s:cvode")
Running command: "" <> buildModelFMU(ClaRa.Components.VolumesValvesFittings.Pipes.Check.OnePhaseFlow.Test_Pipe_L1_TML,fileNamePrefix="ClaRa_dev_ClaRa_Components_VolumesValvesFittings_Pipes_Check_OnePhaseFlow_Test_Pipe_L1_TML",fmuType="me_cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(ClaRa.Components.VolumesValvesFittings.Pipes.Check.OnePhaseFlow.Test_Pipe_L1_TML,fileNamePrefix="ClaRa_dev_ClaRa_Components_VolumesValvesFittings_Pipes_Check_OnePhaseFlow_Test_Pipe_L1_TML",fmuType="me_cs",version="2.0",platforms={"static"}) [Timeout 800]
"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: 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: 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.
Notification: Performance of FrontEnd - loaded program: time 0.002694/0.002694, allocations: 160.5 kB / 0.6902 GB, free: 46.79 MB / 0.5105 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1274/0.13, allocations: 89.26 MB / 0.7773 GB, free: 3.051 MB / 0.5418 GB
Notification: Performance of NFInst.instantiate(ClaRa.Components.VolumesValvesFittings.Pipes.Check.OnePhaseFlow.Test_Pipe_L1_TML): time 0.008417/0.1385, allocations: 9.798 MB / 0.7869 GB, free: 9.195 MB / 0.5574 GB
Notification: Performance of NFInst.instExpressions: time 0.01585/0.1543, allocations: 16.36 MB / 0.8029 GB, free: 8.789 MB / 0.573 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001163/0.1555, allocations: 51.62 kB / 0.8029 GB, free: 8.738 MB / 0.573 GB
Notification: Performance of NFTyping.typeComponents: time 0.001918/0.1574, allocations: 0.9882 MB / 0.8039 GB, free: 7.746 MB / 0.573 GB
Notification: Performance of NFTyping.typeBindings: time 0.001856/0.1593, allocations: 1.201 MB / 0.8051 GB, free: 6.539 MB / 0.573 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002874/0.1621, allocations: 1.886 MB / 0.8069 GB, free: 4.648 MB / 0.573 GB
Notification: Performance of NFFlatten.flatten: time 0.004009/0.1661, allocations: 5.819 MB / 0.8126 GB, free: 14.82 MB / 0.5887 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002129/0.1683, allocations: 1.906 MB / 0.8144 GB, free: 12.88 MB / 0.5887 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002045/0.1703, allocations: 2.142 MB / 0.8165 GB, free: 10.73 MB / 0.5887 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00267/0.173, allocations: 2.581 MB / 0.8191 GB, free: 8.145 MB / 0.5887 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005064/0.1735, allocations: 420 kB / 0.8195 GB, free: 7.734 MB / 0.5887 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002128/0.1756, allocations: 1.497 MB / 0.8209 GB, free: 6.234 MB / 0.5887 GB
Notification: Performance of NFScalarize.scalarize: time 0.0009521/0.1766, allocations: 1.609 MB / 0.8225 GB, free: 4.621 MB / 0.5887 GB
Notification: Performance of NFVerifyModel.verify: time 0.001198/0.1778, allocations: 1.82 MB / 0.8243 GB, free: 2.793 MB / 0.5887 GB
Notification: Performance of NFConvertDAE.convert: time 0.004705/0.1825, allocations: 6.971 MB / 0.8311 GB, free: 11.8 MB / 0.6043 GB
Notification: Performance of FrontEnd - DAE generated: time 2.865e-06/0.1825, allocations: 0 / 0.8311 GB, free: 11.8 MB / 0.6043 GB
Notification: Performance of FrontEnd: time 1.613e-06/0.1825, allocations: 0 / 0.8311 GB, free: 11.8 MB / 0.6043 GB
Notification: Performance of Transformations before backend: time 3.643e-05/0.1825, allocations: 0 / 0.8311 GB, free: 11.8 MB / 0.6043 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 805
 * Number of variables: 805
Notification: Performance of Generate backend data structure: time 0.007464/0.19, allocations: 5.284 MB / 0.8362 GB, free: 6.449 MB / 0.6043 GB
Notification: Performance of prepare preOptimizeDAE: time 4.499e-05/0.19, allocations: 8.031 kB / 0.8362 GB, free: 6.441 MB / 0.6043 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0003825/0.1904, allocations: 414.5 kB / 0.8366 GB, free: 6.023 MB / 0.6043 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0007535/0.1912, allocations: 489 kB / 0.8371 GB, free: 5.543 MB / 0.6043 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004035/0.1952, allocations: 3.343 MB / 0.8404 GB, free: 2.137 MB / 0.6043 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001928/0.1954, allocations: 263.8 kB / 0.8406 GB, free: 1.863 MB / 0.6043 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003677/0.1957, allocations: 255.9 kB / 0.8409 GB, free: 1.613 MB / 0.6043 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005957/0.2017, allocations: 5.408 MB / 0.8461 GB, free: 11.82 MB / 0.6199 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.842e-05/0.2018, allocations: 19.83 kB / 0.8462 GB, free: 11.8 MB / 0.6199 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002058/0.202, allocations: 92 kB / 0.8462 GB, free: 11.71 MB / 0.6199 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001746/0.2021, allocations: 304.5 kB / 0.8465 GB, free: 11.41 MB / 0.6199 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0072/0.2093, allocations: 5.709 MB / 0.8521 GB, free: 5.688 MB / 0.6199 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.01534/0.2247, allocations: 17.02 MB / 0.8687 GB, free: 4.277 MB / 0.6355 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004422/0.2291, allocations: 3.371 MB / 0.872 GB, free: 0.8594 MB / 0.6355 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002222/0.2313, allocations: 1.897 MB / 0.8739 GB, free: 14.93 MB / 0.6512 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002488/0.2316, allocations: 130 kB / 0.874 GB, free: 14.8 MB / 0.6512 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.75e-05/0.2316, allocations: 72.66 kB / 0.8741 GB, free: 14.72 MB / 0.6512 GB
Notification: Performance of pre-optimization done (n=378): time 4.168e-06/0.2316, allocations: 0 / 0.8741 GB, free: 14.72 MB / 0.6512 GB
Notification: Performance of matching and sorting (n=380): time 0.0199/0.2515, allocations: 14.79 MB / 0.8885 GB, free: 15.82 MB / 0.6668 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001004/0.2516, allocations: 316.9 kB / 0.8888 GB, free: 15.45 MB / 0.6668 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002164/0.2538, allocations: 2.525 MB / 0.8913 GB, free: 12.91 MB / 0.6668 GB
Notification: Performance of collectPreVariables (initialization): time 0.000171/0.2539, allocations: 77.7 kB / 0.8914 GB, free: 12.82 MB / 0.6668 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007403/0.2547, allocations: 1.324 MB / 0.8927 GB, free: 11.49 MB / 0.6668 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000663/0.2554, allocations: 1.371 MB / 0.894 GB, free: 10.11 MB / 0.6668 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0008952/0.2562, allocations: 0.8572 MB / 0.8948 GB, free: 9.238 MB / 0.6668 GB
Notification: Performance of setup shared object (initialization): time 5.885e-05/0.2563, allocations: 301.1 kB / 0.8951 GB, free: 8.941 MB / 0.6668 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002615/0.2589, allocations: 2.15 MB / 0.8972 GB, free: 6.781 MB / 0.6668 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003182/0.2621, allocations: 3.103 MB / 0.9002 GB, free: 3.301 MB / 0.6668 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.2612/0.5233, allocations: 5.217 MB / 0.9053 GB, free: 114.4 MB / 0.6668 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.077e-05/0.5233, allocations: 6.781 kB / 0.9053 GB, free: 114.4 MB / 0.6668 GB
Notification: Performance of matching and sorting (n=551) (initialization): time 0.00843/0.5317, allocations: 6.036 MB / 0.9112 GB, free: 112.5 MB / 0.6668 GB
Notification: Performance of prepare postOptimizeDAE: time 2.99e-05/0.5318, allocations: 15.64 kB / 0.9113 GB, free: 112.5 MB / 0.6668 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.006845/0.5386, allocations: 5.074 MB / 0.9162 GB, free: 110.7 MB / 0.6668 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001178/0.5398, allocations: 0.6172 MB / 0.9168 GB, free: 110.6 MB / 0.6668 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002916/0.5427, allocations: 1.099 MB / 0.9179 GB, free: 110.5 MB / 0.6668 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001676/0.5444, allocations: 1.509 MB / 0.9194 GB, free: 109.6 MB / 0.6668 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001856/0.5462, allocations: 253.4 kB / 0.9196 GB, free: 109.6 MB / 0.6668 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003088/0.5466, allocations: 221.8 kB / 0.9198 GB, free: 109.5 MB / 0.6668 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.004297/0.5509, allocations: 2.946 MB / 0.9227 GB, free: 108.4 MB / 0.6668 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003472/0.5543, allocations: 3.097 MB / 0.9257 GB, free: 106.5 MB / 0.6668 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.005276/0.5596, allocations: 5.197 MB / 0.9308 GB, free: 103.7 MB / 0.6668 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.331e-05/0.5596, allocations: 10.16 kB / 0.9308 GB, free: 103.7 MB / 0.6668 GB
Notification: Performance of matching and sorting (n=551) (initialization_lambda0): time 0.006567/0.5662, allocations: 5.81 MB / 0.9365 GB, free: 101.6 MB / 0.6668 GB
Notification: Performance of prepare postOptimizeDAE: time 2.046e-05/0.5662, allocations: 20.16 kB / 0.9365 GB, free: 101.6 MB / 0.6668 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.005146/0.5714, allocations: 4.856 MB / 0.9412 GB, free: 97.2 MB / 0.6668 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001364/0.5715, allocations: 107.4 kB / 0.9413 GB, free: 97.09 MB / 0.6668 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002473/0.574, allocations: 1.171 MB / 0.9425 GB, free: 95.92 MB / 0.6668 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0008068/0.5748, allocations: 1.589 MB / 0.944 GB, free: 94.23 MB / 0.6668 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00148/0.5762, allocations: 229.4 kB / 0.9443 GB, free: 94.02 MB / 0.6668 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002256/0.5765, allocations: 219.9 kB / 0.9445 GB, free: 93.8 MB / 0.6668 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 105
 * 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 (513):
 * Single equations (assignments): 512
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(3,36)}
Notification: Performance of prepare postOptimizeDAE: time 0.0007903/0.5773, allocations: 415.2 kB / 0.9449 GB, free: 93.41 MB / 0.6668 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004086/0.5777, allocations: 358.3 kB / 0.9452 GB, free: 93.25 MB / 0.6668 GB
Warning: After manipulating the system with postOptModule wrapFunctionCalls the system is unbalanced. This indicates that the original system is singular. You can use -d=dumpCSE and -d=dumpCSE_verbose for more information.
Error: Too many equations, over-determined system. The model has 457 equation(s) and 445 variable(s).
Error: ($cse113, $cse114, $cse115, $cse116, $cse117, $cse118, $cse119, $cse120, $cse121, $cse122, $cse123, $cse124) = TILMedia.Internals.VLEFluid.AdditionalObjectFunctions.ObjectFunctions.VLEProperties_phxi(tube.outlet.p, -1.0, {}, massFlowSink.fluidOut.vleFluidPointer) has size 12 but 2 variables (tube.outlet.p, massFlowSink.eye.p)
Error: Internal error Transformation Module PFPlusExt index Reduction Method Pantelides failed!
Notification: Performance of <failed> postOpt wrapFunctionCalls (simulation): time 0.00389/0.5816, allocations: 3.734 MB / 0.9488 GB, free: 89.61 MB / 0.6668 GB
Error: post-optimization module wrapFunctionCalls (simulation) failed.
"
[Timeout remaining time 799]
[Calling sys.exit(0), Time elapsed: 3.431143934838474]