Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.FixedResistances.Validation.LosslessPipe.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.001963/0.001963, allocations: 114.8 kB / 17.16 MB, free: 5.895 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.002308/0.002308, allocations: 210.2 kB / 20.13 MB, free: 2.949 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.69/1.69, allocations: 230.6 MB / 253.5 MB, free: 15.11 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/Building/BuildingEnvelope/HeatTransfer/package.mo:2:1-40:17:writable] Warning: Soil_case_nappe was referenced in the package.order file, but was not found in package.mo, Soil_case_nappe/package.mo or Soil_case_nappe.mo.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/package.mo): time 0.9781/0.9781, allocations: 144.9 MB / 454.5 MB, free: 10.01 MB / 350.1 MB
"
[Timeout remaining time 179]
Using package BuildSysPro with version 3.6.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/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: "" <> buildModelFMU(BuildSysPro.IBPSA.Fluid.FixedResistances.Validation.LosslessPipe,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_FixedResistances_Validation_LosslessPipe",fmuType="cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(BuildSysPro.IBPSA.Fluid.FixedResistances.Validation.LosslessPipe,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_FixedResistances_Validation_LosslessPipe",fmuType="cs",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: BuildSysPro 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.00202/0.00202, allocations: 65.16 kB / 0.6287 GB, free: 33.69 MB / 0.4981 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1675/0.1695, allocations: 87.83 MB / 0.7145 GB, free: 11.75 MB / 0.5294 GB
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.FixedResistances.Validation.LosslessPipe): time 0.6248/0.7943, allocations: 164.7 MB / 0.8753 GB, free: 3.41 MB / 0.67 GB
Notification: Performance of NFInst.instExpressions: time 0.001859/0.7962, allocations: 0.9757 MB / 0.8763 GB, free: 3.379 MB / 0.67 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003497/0.7966, allocations: 16.06 kB / 0.8763 GB, free: 3.379 MB / 0.67 GB
Notification: Performance of NFTyping.typeComponents: time 0.000671/0.7972, allocations: 154.7 kB / 0.8765 GB, free: 3.379 MB / 0.67 GB
Notification: Performance of NFTyping.typeBindings: time 0.002078/0.7993, allocations: 0.6629 MB / 0.8771 GB, free: 3.352 MB / 0.67 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0008967/0.8002, allocations: 219.1 kB / 0.8773 GB, free: 3.348 MB / 0.67 GB
Notification: Performance of NFFlatten.flatten: time 0.0009445/0.8011, allocations: 0.5217 MB / 0.8778 GB, free: 3.344 MB / 0.67 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003983/0.8015, allocations: 148.4 kB / 0.878 GB, free: 3.336 MB / 0.67 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0005871/0.8021, allocations: 239.8 kB / 0.8782 GB, free: 3.336 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0002748/0.8024, allocations: 171.3 kB / 0.8784 GB, free: 3.336 MB / 0.67 GB
Notification: Performance of NFPackage.collectConstants: time 3.952e-05/0.8024, allocations: 14.88 kB / 0.8784 GB, free: 3.336 MB / 0.67 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00123/0.8037, allocations: 0.5852 MB / 0.8789 GB, free: 3.328 MB / 0.67 GB
Notification: Performance of NFScalarize.scalarize: time 0.0001399/0.8038, allocations: 85.34 kB / 0.879 GB, free: 3.328 MB / 0.67 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001906/0.804, allocations: 114 kB / 0.8791 GB, free: 3.328 MB / 0.67 GB
Notification: Performance of NFConvertDAE.convert: time 0.001175/0.8052, allocations: 0.4944 MB / 0.8796 GB, free: 3.309 MB / 0.67 GB
Notification: Performance of FrontEnd - DAE generated: time 5.571e-06/0.8052, allocations: 6.562 kB / 0.8796 GB, free: 3.305 MB / 0.67 GB
Notification: Performance of FrontEnd: time 2.535e-06/0.8052, allocations: 1.203 kB / 0.8796 GB, free: 3.305 MB / 0.67 GB
Notification: Performance of Transformations before backend: time 7.193e-06/0.8052, allocations: 0 / 0.8796 GB, free: 3.305 MB / 0.67 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 41
 * Number of variables: 41
Notification: Performance of Generate backend data structure: time 0.00189/0.8071, allocations: 0.6154 MB / 0.8802 GB, free: 2.852 MB / 0.67 GB
Notification: Performance of prepare preOptimizeDAE: time 5.175e-05/0.8071, allocations: 9.031 kB / 0.8802 GB, free: 2.852 MB / 0.67 GB
Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 2.081e-05/0.8072, allocations: 6.297 kB / 0.8802 GB, free: 2.852 MB / 0.67 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 5.578e-05/0.8072, allocations: 52.38 kB / 0.8803 GB, free: 2.812 MB / 0.67 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0003097/0.8075, allocations: 46.52 kB / 0.8803 GB, free: 2.801 MB / 0.67 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0007303/0.8083, allocations: 288.8 kB / 0.8806 GB, free: 18.58 MB / 0.6856 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 2.624e-05/0.8083, allocations: 15.78 kB / 0.8806 GB, free: 18.58 MB / 0.6856 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 4.08e-05/0.8083, allocations: 15.25 kB / 0.8806 GB, free: 18.58 MB / 0.6856 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0005801/0.8089, allocations: 245.4 kB / 0.8809 GB, free: 18.55 MB / 0.6856 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.137e-05/0.8089, allocations: 0 / 0.8809 GB, free: 18.55 MB / 0.6856 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 2.533e-05/0.8089, allocations: 5.719 kB / 0.8809 GB, free: 18.55 MB / 0.6856 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.766e-05/0.809, allocations: 9.234 kB / 0.8809 GB, free: 18.55 MB / 0.6856 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0006664/0.8096, allocations: 259 kB / 0.8811 GB, free: 18.54 MB / 0.6856 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.001427/0.8111, allocations: 0.8344 MB / 0.882 GB, free: 18.12 MB / 0.6856 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0003406/0.8114, allocations: 135.3 kB / 0.8821 GB, free: 18.09 MB / 0.6856 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0002434/0.8116, allocations: 106.3 kB / 0.8822 GB, free: 18.08 MB / 0.6856 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003179/0.812, allocations: 189.5 kB / 0.8824 GB, free: 17.89 MB / 0.6856 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.132e-05/0.812, allocations: 34.27 kB / 0.8824 GB, free: 17.86 MB / 0.6856 GB
Notification: Performance of pre-optimization done (n=14): time 1.843e-06/0.812, allocations: 0.9062 kB / 0.8824 GB, free: 17.86 MB / 0.6856 GB
Notification: Performance of matching and sorting (n=14): time 0.0009414/0.8129, allocations: 303.7 kB / 0.8827 GB, free: 17.81 MB / 0.6856 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.663e-05/0.813, allocations: 54.22 kB / 0.8827 GB, free: 17.75 MB / 0.6856 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0002636/0.8133, allocations: 240.5 kB / 0.883 GB, free: 17.64 MB / 0.6856 GB
Notification: Performance of collectPreVariables (initialization): time 3.327e-05/0.8133, allocations: 28.39 kB / 0.883 GB, free: 17.61 MB / 0.6856 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001023/0.8134, allocations: 146.3 kB / 0.8831 GB, free: 17.52 MB / 0.6856 GB
Notification: Performance of collectInitialBindings (initialization): time 4.083e-05/0.8134, allocations: 51.94 kB / 0.8832 GB, free: 17.48 MB / 0.6856 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 7.263e-05/0.8135, allocations: 35.66 kB / 0.8832 GB, free: 17.46 MB / 0.6856 GB
Notification: Performance of setup shared object (initialization): time 0.0001507/0.8137, allocations: 332.8 kB / 0.8835 GB, free: 17.15 MB / 0.6856 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0001901/0.8138, allocations: 67.27 kB / 0.8836 GB, free: 17.15 MB / 0.6856 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0002318/0.8141, allocations: 106.5 kB / 0.8837 GB, free: 17.13 MB / 0.6856 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0003786/0.8145, allocations: 177.4 kB / 0.8839 GB, free: 17.1 MB / 0.6856 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.467e-06/0.8145, allocations: 1.031 kB / 0.8839 GB, free: 17.1 MB / 0.6856 GB
Notification: Performance of matching and sorting (n=15) (initialization): time 0.0004953/0.815, allocations: 207.8 kB / 0.8841 GB, free: 17.06 MB / 0.6856 GB
Notification: Performance of prepare postOptimizeDAE: time 1.895e-05/0.815, allocations: 6.688 kB / 0.8841 GB, free: 17.06 MB / 0.6856 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.625e-06/0.815, allocations: 5.062 kB / 0.8841 GB, free: 17.06 MB / 0.6856 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.81e-05/0.815, allocations: 4.781 kB / 0.8841 GB, free: 17.06 MB / 0.6856 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0002069/0.8152, allocations: 34.02 kB / 0.8841 GB, free: 17.05 MB / 0.6856 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 8.366e-06/0.8152, allocations: 4.531 kB / 0.8841 GB, free: 17.05 MB / 0.6856 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0001964/0.8154, allocations: 31.23 kB / 0.8841 GB, free: 17.04 MB / 0.6856 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.309e-05/0.8155, allocations: 5.062 kB / 0.8842 GB, free: 17.04 MB / 0.6856 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 3
 * 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 (15):
 * Single equations (assignments): 15
 * 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.0001586/0.8156, allocations: 141.7 kB / 0.8843 GB, free: 16.93 MB / 0.6856 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 5.702e-05/0.8157, allocations: 27.2 kB / 0.8843 GB, free: 16.92 MB / 0.6856 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 8.548e-05/0.8158, allocations: 29.94 kB / 0.8843 GB, free: 16.91 MB / 0.6856 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.66e-06/0.8158, allocations: 8.656 kB / 0.8844 GB, free: 16.91 MB / 0.6856 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.402e-06/0.8158, allocations: 0.75 kB / 0.8844 GB, free: 16.91 MB / 0.6856 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.437e-06/0.8158, allocations: 1.188 kB / 0.8844 GB, free: 16.91 MB / 0.6856 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001122/0.8169, allocations: 0.6718 MB / 0.885 GB, free: 16.55 MB / 0.6856 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.39e-06/0.8169, allocations: 6.188 kB / 0.885 GB, free: 16.55 MB / 0.6856 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000176/0.8171, allocations: 34.31 kB / 0.885 GB, free: 16.55 MB / 0.6856 GB
Notification: Performance of postOpt tearingSystem (simulation): time 6.482e-06/0.8171, allocations: 2.219 kB / 0.8851 GB, free: 16.55 MB / 0.6856 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 1.653e-05/0.8171, allocations: 5.562 kB / 0.8851 GB, free: 16.55 MB / 0.6856 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 5.581e-06/0.8171, allocations: 5.625 kB / 0.8851 GB, free: 16.55 MB / 0.6856 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.759e-06/0.8171, allocations: 1.781 kB / 0.8851 GB, free: 16.55 MB / 0.6856 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0005626/0.8177, allocations: 363.3 kB / 0.8854 GB, free: 16.35 MB / 0.6856 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001212/0.8178, allocations: 114 kB / 0.8855 GB, free: 16.24 MB / 0.6856 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 4.054e-05/0.8178, allocations: 7.766 kB / 0.8855 GB, free: 16.24 MB / 0.6856 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0001786/0.818, allocations: 12.7 kB / 0.8855 GB, free: 16.24 MB / 0.6856 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 6.073e-05/0.8181, allocations: 14.11 kB / 0.8856 GB, free: 16.24 MB / 0.6856 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 1.661e-05/0.8181, allocations: 8.047 kB / 0.8856 GB, free: 16.24 MB / 0.6856 GB
Notification: Performance of sorting global known variables: time 0.0002044/0.8183, allocations: 177.7 kB / 0.8857 GB, free: 16.16 MB / 0.6856 GB
Notification: Performance of sort global known variables: time 8e-08/0.8183, allocations: 3.688 kB / 0.8857 GB, free: 16.16 MB / 0.6856 GB
Notification: Performance of remove unused functions: time 0.0004312/0.8187, allocations: 63.52 kB / 0.8858 GB, free: 16.15 MB / 0.6856 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 8
 * 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 (14):
 * Single equations (assignments): 14
 * 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.00115/0.8199, allocations: 0.9226 MB / 0.8867 GB, free: 15.43 MB / 0.6856 GB
Notification: Performance of simCode: created initialization part: time 0.0005665/0.8204, allocations: 173.4 kB / 0.8869 GB, free: 15.42 MB / 0.6856 GB
Notification: Performance of simCode: created event and clocks part: time 2.935e-06/0.8204, allocations: 1.688 kB / 0.8869 GB, free: 15.42 MB / 0.6856 GB
Notification: Performance of simCode: created simulation system equations: time 0.0002607/0.8207, allocations: 94.42 kB / 0.887 GB, free: 15.42 MB / 0.6856 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0008386/0.8215, allocations: 132 kB / 0.8871 GB, free: 15.4 MB / 0.6856 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0036/0.8251, allocations: 2.476 MB / 0.8895 GB, free: 13.99 MB / 0.6856 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0003691/0.8255, allocations: 0.7517 MB / 0.8902 GB, free: 13.3 MB / 0.6856 GB
Notification: Performance of simCode: alias equations: time 0.0002375/0.8257, allocations: 59.11 kB / 0.8903 GB, free: 13.3 MB / 0.6856 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001128/0.8259, allocations: 68.38 kB / 0.8904 GB, free: 13.29 MB / 0.6856 GB
Notification: Performance of SimCode: time 9.02e-07/0.8259, allocations: 0 / 0.8904 GB, free: 13.29 MB / 0.6856 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.0251/0.851, allocations: 6.975 MB / 0.8972 GB, free: 12.79 MB / 0.6856 GB
Notification: Performance of buildModelFMU: Generate platform static: time 8.557/9.408, allocations: 8.922 kB / 0.8972 GB, free: 12.78 MB / 0.6856 GB
"
[Timeout remaining time 650]
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.FixedResistances.Validation.LosslessPipe.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.FixedResistances.Validation.LosslessPipe.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.FixedResistances.Validation.LosslessPipe.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.FixedResistances.Validation.LosslessPipe.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_BuildSysPro_BuildSysPro_IBPSA_Fluid_FixedResistances_Validation_LosslessPipe_fmu --startTime=0 --stopTime=1 --stepSize=0.0004 --timeout=50 --tolerance=1e-06 BuildSysPro_BuildSysPro_IBPSA_Fluid_FixedResistances_Validation_LosslessPipe.fmu > BuildSysPro_BuildSysPro.IBPSA.Fluid.FixedResistances.Validation.LosslessPipe.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 13.58541838900419]
Failed to read output from testmodel.py, exit status != 0:
9.538265942013822 9.556979532 8.748195662
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff069deb3a0>