Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstanceReverseFlowPrescribedHeatFlowRate.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.00157/0.00157, allocations: 96.41 kB / 20.51 MB, free: 1.152 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.001375/0.001375, allocations: 214.8 kB / 23.81 MB, free: 4.348 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.409/1.409, allocations: 230.7 MB / 257.6 MB, free: 7.727 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo): time 0.9282/0.9282, allocations: 149.9 MB / 463.9 MB, free: 10.36 MB / 366.1 MB " [Timeout remaining time 179] Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/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: translateModel(IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstanceReverseFlowPrescribedHeatFlowRate,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstanceReverseFlowPrescribedHeatFlowRate") translateModel(IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstanceReverseFlowPrescribedHeatFlowRate,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstanceReverseFlowPrescribedHeatFlowRate") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.097e-05/2.097e-05, allocations: 4.359 kB / 0.6424 GB, free: 9.582 MB / 478.1 MB Notification: Performance of NFInst.instantiate(IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstanceReverseFlowPrescribedHeatFlowRate): time 0.5618/0.5618, allocations: 168.5 MB / 0.8069 GB, free: 6.953 MB / 0.5762 GB Notification: Performance of NFInst.instExpressions: time 0.008186/0.57, allocations: 5.409 MB / 0.8122 GB, free: 6.789 MB / 0.5762 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001159/0.5711, allocations: 54.59 kB / 0.8123 GB, free: 6.789 MB / 0.5762 GB Notification: Performance of NFTyping.typeComponents: time 0.00125/0.5724, allocations: 0.5466 MB / 0.8128 GB, free: 6.777 MB / 0.5762 GB Notification: Performance of NFTyping.typeBindings: time 0.003444/0.5758, allocations: 1.678 MB / 0.8144 GB, free: 6.699 MB / 0.5762 GB Notification: Performance of NFTyping.typeClassSections: time 0.002697/0.5785, allocations: 1.236 MB / 0.8156 GB, free: 6.656 MB / 0.5762 GB Notification: Performance of NFFlatten.flatten: time 0.0028/0.5813, allocations: 3.084 MB / 0.8186 GB, free: 6.605 MB / 0.5762 GB Notification: Performance of NFFlatten.resolveConnections: time 0.001153/0.5825, allocations: 0.8567 MB / 0.8195 GB, free: 6.531 MB / 0.5762 GB Notification: Performance of NFEvalConstants.evaluate: time 0.002349/0.5848, allocations: 1.475 MB / 0.8209 GB, free: 6.516 MB / 0.5762 GB Notification: Performance of NFSimplifyModel.simplify: time 0.00163/0.5864, allocations: 0.9016 MB / 0.8218 GB, free: 6.41 MB / 0.5762 GB Notification: Performance of NFPackage.collectConstants: time 0.0001596/0.5866, allocations: 103.8 kB / 0.8219 GB, free: 6.41 MB / 0.5762 GB Notification: Performance of NFFlatten.collectFunctions: time 0.0023/0.5889, allocations: 1.266 MB / 0.8231 GB, free: 6.391 MB / 0.5762 GB Notification: Performance of combineBinaries: time 0.001952/0.5909, allocations: 2.599 MB / 0.8257 GB, free: 5.422 MB / 0.5762 GB Notification: Performance of replaceArrayConstructors: time 0.0009908/0.5918, allocations: 1.626 MB / 0.8273 GB, free: 4.605 MB / 0.5762 GB Notification: Performance of NFVerifyModel.verify: time 0.0002656/0.5921, allocations: 107.1 kB / 0.8274 GB, free: 4.605 MB / 0.5762 GB Notification: Performance of FrontEnd: time 0.0002489/0.5924, allocations: 45.83 kB / 0.8274 GB, free: 4.598 MB / 0.5762 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 216 (200) * Number of variables: 216 (184) Notification: Performance of [SIM] Bindings: time 0.005277/0.5976, allocations: 6.404 MB / 0.8337 GB, free: 1.902 MB / 0.5762 GB Notification: Performance of [SIM] FunctionAlias: time 0.0006472/0.5983, allocations: 0.6812 MB / 0.8343 GB, free: 1.539 MB / 0.5762 GB Notification: Performance of [SIM] Early Inline: time 0.003114/0.6014, allocations: 3.493 MB / 0.8377 GB, free: 15.32 MB / 0.5919 GB Notification: Performance of [SIM] Simplify 1: time 0.0009977/0.6024, allocations: 0.5731 MB / 0.8383 GB, free: 14.96 MB / 0.5919 GB Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information. Notification: Performance of [SIM] Alias: time 0.005999/0.6084, allocations: 4.416 MB / 0.8426 GB, free: 12.06 MB / 0.5919 GB Notification: Performance of [SIM] Simplify 2: time 0.0006967/0.6091, allocations: 485 kB / 0.8431 GB, free: 11.76 MB / 0.5919 GB Notification: Performance of [SIM] Remove Stream: time 0.0003768/0.6095, allocations: 299 kB / 0.8434 GB, free: 11.53 MB / 0.5919 GB Notification: Performance of [SIM] Detect States: time 0.0007504/0.6102, allocations: 0.6409 MB / 0.844 GB, free: 10.97 MB / 0.5919 GB Notification: Performance of [SIM] Events: time 0.0004115/0.6106, allocations: 281.5 kB / 0.8443 GB, free: 10.8 MB / 0.5919 GB Notification: Performance of [SIM] Partitioning: time 0.001148/0.6118, allocations: 1.01 MB / 0.8452 GB, free: 10.17 MB / 0.5919 GB Notification: Performance of [SIM] Causalize: time 0.005756/0.6175, allocations: 4.57 MB / 0.8497 GB, free: 8.391 MB / 0.5919 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.002085/0.6196, allocations: 2.246 MB / 0.8519 GB, free: 6.863 MB / 0.5919 GB Notification: Performance of [INI] Simplify: time 0.002637/0.6223, allocations: 1.519 MB / 0.8534 GB, free: 5.887 MB / 0.5919 GB Notification: Performance of [INI] Inline: time 0.004205/0.6265, allocations: 4.204 MB / 0.8575 GB, free: 2.953 MB / 0.5919 GB Notification: Performance of [INI] Partitioning: time 0.0001453/0.6266, allocations: 65.16 kB / 0.8576 GB, free: 2.91 MB / 0.5919 GB Notification: Performance of [INI] Cleanup: time 0.0006298/0.6272, allocations: 0.5541 MB / 0.8581 GB, free: 2.484 MB / 0.5919 GB Warning: NBResolveSingularities.balanceInitialization reports an overdetermined initialization! Checking for consistency is not yet supported, following equations had to be removed: [SCAL] (1) volDyn.dynBal.p_start = volDyn.p_start ($RES_BND_289); Notification: Performance of [INI] Causalize: time 0.008305/0.6355, allocations: 5.852 MB / 0.8638 GB, free: 13.29 MB / 0.6075 GB Notification: Performance of [INI] Tearing: time 8.637e-05/0.6356, allocations: 100.5 kB / 0.8639 GB, free: 13.2 MB / 0.6075 GB Notification: Performance of [SIM] Initialization: time 1.042e-06/0.6356, allocations: 0 / 0.8639 GB, free: 13.2 MB / 0.6075 GB Notification: Performance of [SIM] DAE-Mode: time 0.001146/0.6368, allocations: 0.7237 MB / 0.8646 GB, free: 12.46 MB / 0.6075 GB Notification: Performance of [SIM] Remove Dummies: time 8.966e-06/0.6368, allocations: 1.312 kB / 0.8646 GB, free: 12.46 MB / 0.6075 GB Notification: Performance of [SIM] Tearing: time 9.7e-05/0.6369, allocations: 154.6 kB / 0.8648 GB, free: 12.31 MB / 0.6075 GB Notification: Performance of [SIM] Categorize: time 2.268e-05/0.6369, allocations: 4 kB / 0.8648 GB, free: 12.31 MB / 0.6075 GB Notification: Performance of [SIM] Solve: time 0.004714/0.6416, allocations: 3.531 MB / 0.8682 GB, free: 8.836 MB / 0.6075 GB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref $DER.volDyn.ports[1].p is neither a seed nor a partial candidate! " [Timeout remaining time 659] [Calling sys.exit(0), Time elapsed: 4.122572522959672] Failed to read output from testmodel.py, exit status != 0: 0.6507586159859784 0.664603681 0.069263115 Calling exit ...