Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.Sensors.Examples.RelativeHumidity.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.00123/0.00123, allocations: 113.5 kB / 19.73 MB, free: 2.242 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.001419/0.001419, allocations: 211.3 kB / 23.04 MB, free: 5.074 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.439/1.439, allocations: 230.6 MB / 256.8 MB, free: 7.98 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.9123/0.9123, allocations: 145 MB / 458.2 MB, free: 15.54 MB / 366.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.Sensors.Examples.RelativeHumidity,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_Sensors_Examples_RelativeHumidity",fmuType="cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(BuildSysPro.IBPSA.Fluid.Sensors.Examples.RelativeHumidity,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_Sensors_Examples_RelativeHumidity",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.00201/0.00201, allocations: 62.62 kB / 0.6339 GB, free: 7.301 MB / 462.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1814/0.1834, allocations: 87.89 MB / 0.7198 GB, free: 15.42 MB / 0.545 GB
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.Sensors.Examples.RelativeHumidity): time 0.5508/0.7341, allocations: 168.9 MB / 0.8847 GB, free: 4.516 MB / 0.6544 GB
Notification: Performance of NFInst.instExpressions: time 0.002975/0.7371, allocations: 1.552 MB / 0.8862 GB, free: 2.957 MB / 0.6544 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002601/0.7374, allocations: 11.88 kB / 0.8862 GB, free: 2.945 MB / 0.6544 GB
Notification: Performance of NFTyping.typeComponents: time 0.000456/0.7378, allocations: 150.9 kB / 0.8864 GB, free: 2.797 MB / 0.6544 GB
Notification: Performance of NFTyping.typeBindings: time 0.001216/0.7391, allocations: 493.9 kB / 0.8869 GB, free: 2.312 MB / 0.6544 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002058/0.7411, allocations: 0.7929 MB / 0.8876 GB, free: 1.52 MB / 0.6544 GB
Notification: Performance of NFFlatten.flatten: time 0.00092/0.742, allocations: 0.7253 MB / 0.8883 GB, free: 0.793 MB / 0.6544 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003792/0.7424, allocations: 207.7 kB / 0.8885 GB, free: 0.5859 MB / 0.6544 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0005764/0.743, allocations: 318.9 kB / 0.8888 GB, free: 280 kB / 0.6544 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003438/0.7433, allocations: 239 kB / 0.8891 GB, free: 40 kB / 0.6544 GB
Notification: Performance of NFPackage.collectConstants: time 4.596e-05/0.7434, allocations: 32 kB / 0.8891 GB, free: 8 kB / 0.6544 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001823/0.7452, allocations: 0.9353 MB / 0.89 GB, free: 15.07 MB / 0.67 GB
Notification: Performance of NFScalarize.scalarize: time 0.0001592/0.7454, allocations: 119.6 kB / 0.8901 GB, free: 14.95 MB / 0.67 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001865/0.7455, allocations: 159.2 kB / 0.8903 GB, free: 14.8 MB / 0.67 GB
Notification: Performance of NFConvertDAE.convert: time 0.001328/0.7469, allocations: 0.7636 MB / 0.891 GB, free: 14.04 MB / 0.67 GB
Notification: Performance of FrontEnd - DAE generated: time 5.721e-06/0.7469, allocations: 4 kB / 0.891 GB, free: 14.03 MB / 0.67 GB
Notification: Performance of FrontEnd: time 1.392e-06/0.7469, allocations: 0 / 0.891 GB, free: 14.03 MB / 0.67 GB
Notification: Performance of Transformations before backend: time 1.154e-05/0.7469, allocations: 0 / 0.891 GB, free: 14.03 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: 56
 * Number of variables: 56
Notification: Performance of Generate backend data structure: time 0.001188/0.7481, allocations: 0.6134 MB / 0.8916 GB, free: 13.39 MB / 0.67 GB
Notification: Performance of prepare preOptimizeDAE: time 4.537e-05/0.7481, allocations: 12.02 kB / 0.8916 GB, free: 13.38 MB / 0.67 GB
Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 1.657e-05/0.7481, allocations: 9.438 kB / 0.8917 GB, free: 13.37 MB / 0.67 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 6.483e-05/0.7482, allocations: 62.55 kB / 0.8917 GB, free: 13.3 MB / 0.67 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004915/0.7487, allocations: 83.69 kB / 0.8918 GB, free: 13.21 MB / 0.67 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0004624/0.7492, allocations: 252.1 kB / 0.892 GB, free: 12.95 MB / 0.67 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.686e-05/0.7492, allocations: 20.5 kB / 0.8921 GB, free: 12.93 MB / 0.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 5.403e-05/0.7493, allocations: 24 kB / 0.8921 GB, free: 12.9 MB / 0.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.000692/0.75, allocations: 331.3 kB / 0.8924 GB, free: 12.56 MB / 0.67 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.181e-05/0.75, allocations: 3.984 kB / 0.8924 GB, free: 12.56 MB / 0.67 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 2.918e-05/0.75, allocations: 11.94 kB / 0.8924 GB, free: 12.55 MB / 0.67 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.638e-06/0.75, allocations: 11.94 kB / 0.8924 GB, free: 12.54 MB / 0.67 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0007567/0.7508, allocations: 290.3 kB / 0.8927 GB, free: 12.25 MB / 0.67 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.001706/0.7525, allocations: 1.025 MB / 0.8937 GB, free: 11.17 MB / 0.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009016/0.7534, allocations: 242.5 kB / 0.8939 GB, free: 10.93 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003383/0.7537, allocations: 124.8 kB / 0.894 GB, free: 10.8 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005296/0.7543, allocations: 95.89 kB / 0.8941 GB, free: 10.71 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.739e-05/0.7543, allocations: 30.56 kB / 0.8942 GB, free: 10.67 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=19): time 1.843e-06/0.7543, allocations: 0 / 0.8942 GB, free: 10.67 MB / 0.67 GB
Notification: Performance of matching and sorting (n=19): time 0.001259/0.7556, allocations: 407.2 kB / 0.8946 GB, free: 10.27 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.435e-05/0.7556, allocations: 51.41 kB / 0.8946 GB, free: 10.2 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0002999/0.7559, allocations: 280.2 kB / 0.8949 GB, free: 9.922 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 3.312e-05/0.7559, allocations: 25.7 kB / 0.8949 GB, free: 9.891 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001346/0.7561, allocations: 172.5 kB / 0.8951 GB, free: 9.719 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 6.536e-05/0.7561, allocations: 71.36 kB / 0.8951 GB, free: 9.648 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 9.15e-05/0.7562, allocations: 45.66 kB / 0.8952 GB, free: 9.598 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 0.0001576/0.7564, allocations: 342.8 kB / 0.8955 GB, free: 9.254 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003351/0.7567, allocations: 107.7 kB / 0.8956 GB, free: 9.152 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0003754/0.7571, allocations: 164.5 kB / 0.8958 GB, free: 8.973 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0006587/0.7578, allocations: 264.9 kB / 0.896 GB, free: 8.695 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.208e-06/0.7578, allocations: 4 kB / 0.896 GB, free: 8.691 MB / 0.67 GB
Notification: Performance of matching and sorting (n=24) (initialization): time 0.0007659/0.7585, allocations: 310.8 kB / 0.8963 GB, free: 8.383 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 1.707e-05/0.7585, allocations: 8 kB / 0.8963 GB, free: 8.375 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.22e-06/0.7586, allocations: 0 / 0.8963 GB, free: 8.375 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.847e-05/0.7586, allocations: 12.09 kB / 0.8963 GB, free: 8.363 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0002839/0.7589, allocations: 59.89 kB / 0.8964 GB, free: 8.305 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 9.067e-06/0.7589, allocations: 4 kB / 0.8964 GB, free: 8.301 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0002467/0.7591, allocations: 39.81 kB / 0.8964 GB, free: 8.262 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.067e-05/0.7591, allocations: 11.94 kB / 0.8964 GB, free: 8.25 MB / 0.67 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 6
 * 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 (24):
 * Single equations (assignments): 24
 * 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.0001783/0.7593, allocations: 153.8 kB / 0.8966 GB, free: 8.09 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 6.166e-05/0.7594, allocations: 35.81 kB / 0.8966 GB, free: 8.055 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0008381/0.7602, allocations: 317.3 kB / 0.8969 GB, free: 7.734 MB / 0.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.266e-06/0.7602, allocations: 0 / 0.8969 GB, free: 7.734 MB / 0.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.011e-06/0.7602, allocations: 7.938 kB / 0.8969 GB, free: 7.727 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.158e-06/0.7602, allocations: 0 / 0.8969 GB, free: 7.727 MB / 0.67 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001639/0.7619, allocations: 0.8322 MB / 0.8977 GB, free: 6.816 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.585e-06/0.7619, allocations: 0 / 0.8977 GB, free: 6.816 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000258/0.7621, allocations: 51.84 kB / 0.8978 GB, free: 6.766 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (simulation): time 7.664e-06/0.7621, allocations: 4.047 kB / 0.8978 GB, free: 6.762 MB / 0.67 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 2.415e-05/0.7622, allocations: 11.98 kB / 0.8978 GB, free: 6.75 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 4.608e-06/0.7622, allocations: 3.984 kB / 0.8978 GB, free: 6.746 MB / 0.67 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.641e-06/0.7622, allocations: 7.938 kB / 0.8978 GB, free: 6.738 MB / 0.67 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001172/0.7633, allocations: 0.5549 MB / 0.8984 GB, free: 6.148 MB / 0.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001128/0.7635, allocations: 47.81 kB / 0.8984 GB, free: 6.102 MB / 0.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 4.625e-05/0.7635, allocations: 11 kB / 0.8984 GB, free: 6.094 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002262/0.7637, allocations: 24.03 kB / 0.8984 GB, free: 6.07 MB / 0.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.3e-05/0.7638, allocations: 27.84 kB / 0.8985 GB, free: 6.043 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 2.863e-05/0.7638, allocations: 8 kB / 0.8985 GB, free: 6.035 MB / 0.67 GB
Notification: Performance of sorting global known variables: time 0.0001848/0.764, allocations: 191.1 kB / 0.8987 GB, free: 5.848 MB / 0.67 GB
Notification: Performance of sort global known variables: time 7.1e-08/0.764, allocations: 0 / 0.8987 GB, free: 5.848 MB / 0.67 GB
Notification: Performance of remove unused functions: time 0.0004745/0.7645, allocations: 119.7 kB / 0.8988 GB, free: 5.73 MB / 0.67 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 7
 * Number of states: 1 (relHum.phi)
 * 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 (19):
 * Single equations (assignments): 19
 * 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.00174/0.7662, allocations: 1.181 MB / 0.8999 GB, free: 4.508 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.000745/0.767, allocations: 247.6 kB / 0.9002 GB, free: 4.266 MB / 0.67 GB
Notification: Performance of simCode: created event and clocks part: time 2.395e-06/0.767, allocations: 0 / 0.9002 GB, free: 4.266 MB / 0.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.0003843/0.7674, allocations: 140.5 kB / 0.9003 GB, free: 4.129 MB / 0.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.000755/0.7681, allocations: 138.6 kB / 0.9004 GB, free: 4.004 MB / 0.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004544/0.7727, allocations: 2.972 MB / 0.9033 GB, free: 0.8906 MB / 0.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004231/0.7731, allocations: 0.7794 MB / 0.9041 GB, free: 88 kB / 0.67 GB
Notification: Performance of simCode: alias equations: time 0.00022/0.7733, allocations: 63.8 kB / 0.9042 GB, free: 24 kB / 0.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001801/0.7735, allocations: 95.47 kB / 0.9042 GB, free: 15.93 MB / 0.6856 GB
Notification: Performance of SimCode: time 5.41e-07/0.7735, allocations: 4 kB / 0.9042 GB, free: 15.92 MB / 0.6856 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.03501/0.8085, allocations: 9.289 MB / 0.9133 GB, free: 6.871 MB / 0.6856 GB
Notification: Performance of buildModelFMU: Generate platform static: time 11.65/12.46, allocations: 6.125 kB / 0.9133 GB, free: 6.867 MB / 0.6856 GB
"
[Timeout remaining time 647]
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Sensors.Examples.RelativeHumidity.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.Sensors.Examples.RelativeHumidity.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.Sensors.Examples.RelativeHumidity.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.Sensors.Examples.RelativeHumidity.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_BuildSysPro_BuildSysPro_IBPSA_Fluid_Sensors_Examples_RelativeHumidity_fmu --startTime=0 --stopTime=600 --stepSize=0.24 --timeout=50 --tolerance=1e-06 BuildSysPro_BuildSysPro_IBPSA_Fluid_Sensors_Examples_RelativeHumidity.fmu > BuildSysPro_BuildSysPro.IBPSA.Fluid.Sensors.Examples.RelativeHumidity.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 16.27230457100086]
Failed to read output from testmodel.py, exit status != 0:
12.631066785077564 12.659222163 11.907054149
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fea9dd0b3a0>