Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance.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.001513/0.001513, allocations: 104.3 kB / 19.77 MB, free: 2.051 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.001493/0.001493, allocations: 219.4 kB / 23.07 MB, free: 4.844 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.429/1.429, allocations: 230.6 MB / 256.9 MB, free: 7.73 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.8038/0.8038, allocations: 134 MB / 447.3 MB, free: 9.859 MB / 350.1 MB " [Timeout remaining time 179] Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.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: translateModel(IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance") translateModel(IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.582e-05/1.582e-05, allocations: 5.891 kB / 0.6198 GB, free: 6.363 MB / 446.1 MB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance): time 0.5223/0.5223, allocations: 168.2 MB / 0.7841 GB, free: 5.586 MB / 0.5606 GB Notification: Performance of NFInst.instExpressions: time 0.007997/0.5303, allocations: 5.392 MB / 0.7893 GB, free: 5.453 MB / 0.5606 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001332/0.5316, allocations: 58.45 kB / 0.7894 GB, free: 5.453 MB / 0.5606 GB Notification: Performance of NFTyping.typeComponents: time 0.001362/0.533, allocations: 0.5387 MB / 0.7899 GB, free: 5.445 MB / 0.5606 GB Notification: Performance of NFTyping.typeBindings: time 0.003688/0.5367, allocations: 1.673 MB / 0.7916 GB, free: 5.371 MB / 0.5606 GB Notification: Performance of NFTyping.typeClassSections: time 0.002668/0.5394, allocations: 1.216 MB / 0.7927 GB, free: 5.34 MB / 0.5606 GB Notification: Performance of NFFlatten.flatten: time 0.002954/0.5423, allocations: 3.046 MB / 0.7957 GB, free: 5.305 MB / 0.5606 GB Notification: Performance of NFFlatten.resolveConnections: time 0.001042/0.5434, allocations: 0.8345 MB / 0.7965 GB, free: 5.234 MB / 0.5606 GB Notification: Performance of NFEvalConstants.evaluate: time 0.001822/0.5452, allocations: 1.28 MB / 0.7978 GB, free: 5.23 MB / 0.5606 GB Notification: Performance of NFSimplifyModel.simplify: time 0.001547/0.5467, allocations: 0.8676 MB / 0.7986 GB, free: 5.207 MB / 0.5606 GB Notification: Performance of NFPackage.collectConstants: time 0.0001501/0.5469, allocations: 102.6 kB / 0.7987 GB, free: 5.203 MB / 0.5606 GB Notification: Performance of NFFlatten.collectFunctions: time 0.002232/0.5491, allocations: 1.251 MB / 0.7999 GB, free: 5.188 MB / 0.5606 GB Notification: Performance of combineBinaries: time 0.001605/0.5507, allocations: 2.527 MB / 0.8024 GB, free: 4.242 MB / 0.5606 GB Notification: Performance of replaceArrayConstructors: time 0.0007885/0.5515, allocations: 1.605 MB / 0.804 GB, free: 3.484 MB / 0.5606 GB Notification: Performance of NFVerifyModel.verify: time 0.0002082/0.5517, allocations: 107.5 kB / 0.8041 GB, free: 3.484 MB / 0.5606 GB Notification: Performance of FrontEnd: time 0.0001963/0.5519, allocations: 42.62 kB / 0.8041 GB, free: 3.477 MB / 0.5606 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 212 (196) * Number of variables: 212 (180) Notification: Performance of [SIM] Bindings: time 0.004584/0.5565, allocations: 6.291 MB / 0.8103 GB, free: 1.27 MB / 0.5606 GB Notification: Performance of [SIM] FunctionAlias: time 0.0005904/0.5571, allocations: 0.6582 MB / 0.8109 GB, free: 1.152 MB / 0.5606 GB Notification: Performance of [SIM] Early Inline: time 0.002537/0.5596, allocations: 2.972 MB / 0.8138 GB, free: 0.5391 MB / 0.5606 GB Notification: Performance of [SIM] Simplify 1: time 0.0007435/0.5604, allocations: 0.506 MB / 0.8143 GB, free: 312 kB / 0.5606 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.005682/0.566, allocations: 4.285 MB / 0.8185 GB, free: 14.17 MB / 0.5762 GB Notification: Performance of [SIM] Simplify 2: time 0.0005812/0.5666, allocations: 421.6 kB / 0.8189 GB, free: 13.96 MB / 0.5762 GB Notification: Performance of [SIM] Remove Stream: time 0.0003347/0.567, allocations: 270.6 kB / 0.8192 GB, free: 13.79 MB / 0.5762 GB Notification: Performance of [SIM] Detect States: time 0.0006562/0.5676, allocations: 0.5705 MB / 0.8197 GB, free: 13.39 MB / 0.5762 GB Notification: Performance of [SIM] Events: time 0.000268/0.5679, allocations: 192 kB / 0.8199 GB, free: 13.3 MB / 0.5762 GB Notification: Performance of [SIM] Partitioning: time 0.0009708/0.5688, allocations: 0.8664 MB / 0.8207 GB, free: 12.87 MB / 0.5762 GB Notification: Performance of [SIM] Causalize: time 0.00515/0.574, allocations: 4.131 MB / 0.8248 GB, free: 11.62 MB / 0.5762 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.001938/0.5759, allocations: 1.901 MB / 0.8266 GB, free: 10.44 MB / 0.5762 GB Notification: Performance of [INI] Simplify: time 0.002684/0.5786, allocations: 1.471 MB / 0.8281 GB, free: 9.484 MB / 0.5762 GB Notification: Performance of [INI] Inline: time 0.003538/0.5822, allocations: 3.578 MB / 0.8316 GB, free: 7.008 MB / 0.5762 GB Notification: Performance of [INI] Partitioning: time 0.0001412/0.5823, allocations: 63.83 kB / 0.8316 GB, free: 6.965 MB / 0.5762 GB Notification: Performance of [INI] Cleanup: time 0.0004699/0.5828, allocations: 475 kB / 0.8321 GB, free: 6.617 MB / 0.5762 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_285); Notification: Performance of [INI] Causalize: time 0.007774/0.5905, allocations: 5.402 MB / 0.8374 GB, free: 2.078 MB / 0.5762 GB Notification: Performance of [INI] Tearing: time 7.384e-05/0.5906, allocations: 100 kB / 0.8374 GB, free: 1.98 MB / 0.5762 GB Notification: Performance of [SIM] Initialization: time 1.252e-06/0.5906, allocations: 1.406 kB / 0.8374 GB, free: 1.98 MB / 0.5762 GB Notification: Performance of [SIM] DAE-Mode: time 0.001007/0.5916, allocations: 0.5665 MB / 0.838 GB, free: 1.391 MB / 0.5762 GB Notification: Performance of [SIM] Remove Dummies: time 1.572e-05/0.5916, allocations: 5.312 kB / 0.838 GB, free: 1.383 MB / 0.5762 GB Notification: Performance of [SIM] Tearing: time 0.0001288/0.5918, allocations: 139.2 kB / 0.8381 GB, free: 1.25 MB / 0.5762 GB Notification: Performance of [SIM] Categorize: time 2.995e-05/0.5918, allocations: 4.859 kB / 0.8381 GB, free: 1.246 MB / 0.5762 GB Notification: Performance of [SIM] Solve: time 0.004335/0.5961, allocations: 2.584 MB / 0.8407 GB, free: 14.71 MB / 0.5919 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: 3.8691394579946063] Failed to read output from testmodel.py, exit status != 0: 0.6043130420148373 0.619041571 0.064221391 Calling exit ...