Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.0.0_ModelicaTest.Blocks.MuxDemux.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.001564/0.001564, allocations: 95.66 kB / 21.25 MB, free: 428 kB / 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.001551/0.001551, allocations: 208.7 kB / 24.55 MB, free: 3.727 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.456/1.456, allocations: 230.6 MB / 258.3 MB, free: 7.793 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo): time 0.2471/0.2471, allocations: 44.94 MB / 359.7 MB, free: 6.031 MB / 286.1 MB " [Timeout remaining time 179] Using package ModelicaTest with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/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(ModelicaTest.Blocks.MuxDemux,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|y1|y2|y3|y4|y5|clock.y|mux5.y.1.|mux5.y.2.|mux5.y.3.|mux5.y.4.|mux5.y.5.|demux5.y.1.|demux5.y.2.|demux5.y.3.|demux5.y.4.|demux5.y.5.|mux3.y.1.|mux3.y.2.|mux3.y.3.|mux2.y.1.|mux2.y.2.|demux2.y.1.|demux2.y.2.|demux3.y.1.|demux3.y.2.|demux3.y.3.",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Blocks.MuxDemux") translateModel(ModelicaTest.Blocks.MuxDemux,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|y1|y2|y3|y4|y5|clock.y|mux5.y.1.|mux5.y.2.|mux5.y.3.|mux5.y.4.|mux5.y.5.|demux5.y.1.|demux5.y.2.|demux5.y.3.|demux5.y.4.|demux5.y.5.|mux3.y.1.|mux3.y.2.|mux3.y.3.|mux2.y.1.|mux2.y.2.|demux2.y.1.|demux2.y.2.|demux3.y.1.|demux3.y.2.|demux3.y.3.",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Blocks.MuxDemux") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.56e-05/2.56e-05, allocations: 2.281 kB / 0.4943 GB, free: 10.07 MB / 366.1 MB Notification: Performance of NFInst.instantiate(ModelicaTest.Blocks.MuxDemux): time 0.002819/0.002845, allocations: 1.553 MB / 0.4958 GB, free: 8.504 MB / 366.1 MB Notification: Performance of NFInst.instExpressions: time 0.0002354/0.00308, allocations: 59.77 kB / 0.4959 GB, free: 8.445 MB / 366.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 5.258e-05/0.003133, allocations: 4 kB / 0.4959 GB, free: 8.441 MB / 366.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0001354/0.003268, allocations: 19.8 kB / 0.4959 GB, free: 8.422 MB / 366.1 MB Notification: Performance of NFTyping.typeBindings: time 2.547e-05/0.003294, allocations: 7.922 kB / 0.4959 GB, free: 8.414 MB / 366.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.0001548/0.003448, allocations: 23.97 kB / 0.4959 GB, free: 8.391 MB / 366.1 MB Notification: Performance of NFFlatten.flatten: time 0.000151/0.003599, allocations: 87.8 kB / 0.496 GB, free: 8.305 MB / 366.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0002362/0.003835, allocations: 70.84 kB / 0.4961 GB, free: 8.23 MB / 366.1 MB Notification: Performance of NFEvalConstants.evaluate: time 4.863e-05/0.003884, allocations: 31.92 kB / 0.4961 GB, free: 8.199 MB / 366.1 MB Notification: Performance of NFSimplifyModel.simplify: time 5.977e-05/0.003944, allocations: 35.78 kB / 0.4962 GB, free: 8.164 MB / 366.1 MB Notification: Performance of NFPackage.collectConstants: time 2.917e-05/0.003973, allocations: 8 kB / 0.4962 GB, free: 8.156 MB / 366.1 MB Notification: Performance of NFFlatten.collectFunctions: time 1.886e-05/0.003992, allocations: 8 kB / 0.4962 GB, free: 8.148 MB / 366.1 MB Notification: Performance of combineBinaries: time 0.0001388/0.004131, allocations: 146.5 kB / 0.4963 GB, free: 8.004 MB / 366.1 MB Notification: Performance of replaceArrayConstructors: time 5.974e-05/0.00419, allocations: 94.72 kB / 0.4964 GB, free: 7.91 MB / 366.1 MB Notification: Performance of NFVerifyModel.verify: time 2.474e-05/0.004215, allocations: 8 kB / 0.4964 GB, free: 7.902 MB / 366.1 MB Notification: Performance of FrontEnd: time 2.71e-05/0.004242, allocations: 15.86 kB / 0.4964 GB, free: 7.887 MB / 366.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 46 (28) * Number of variables: 46 (18) Notification: Performance of [SIM] Bindings: time 0.0006407/0.004883, allocations: 0.4992 MB / 0.4969 GB, free: 7.266 MB / 366.1 MB Notification: Performance of [SIM] FunctionAlias: time 8.118e-05/0.004964, allocations: 67.84 kB / 0.497 GB, free: 7.188 MB / 366.1 MB Notification: Performance of [SIM] Early Inline: time 0.0002576/0.005222, allocations: 260.2 kB / 0.4972 GB, free: 6.906 MB / 366.1 MB Notification: Performance of [SIM] Simplify 1: time 0.0001343/0.005356, allocations: 100.6 kB / 0.4973 GB, free: 6.762 MB / 366.1 MB Notification: Performance of [SIM] Alias: time 0.0007939/0.00615, allocations: 0.506 MB / 0.4978 GB, free: 6.172 MB / 366.1 MB Notification: Performance of [SIM] Simplify 2: time 9.723e-05/0.006247, allocations: 76.72 kB / 0.4979 GB, free: 6.051 MB / 366.1 MB Notification: Performance of [SIM] Remove Stream: time 6.58e-05/0.006313, allocations: 64.41 kB / 0.4979 GB, free: 5.961 MB / 366.1 MB Notification: Performance of [SIM] Detect States: time 0.0001264/0.006439, allocations: 108.8 kB / 0.4981 GB, free: 5.801 MB / 366.1 MB Notification: Performance of [SIM] Events: time 6.06e-05/0.0065, allocations: 19.92 kB / 0.4981 GB, free: 5.781 MB / 366.1 MB Notification: Performance of [SIM] Partitioning: time 0.0001483/0.006648, allocations: 100 kB / 0.4982 GB, free: 5.676 MB / 366.1 MB Notification: Performance of [SIM] Causalize: time 0.0004102/0.007059, allocations: 282.6 kB / 0.4984 GB, free: 5.395 MB / 366.1 MB Notification: Performance of [SIM] After Index Reduction Inline: time 0.0001685/0.007227, allocations: 183.7 kB / 0.4986 GB, free: 5.215 MB / 366.1 MB Notification: Performance of [INI] Simplify: time 0.0002064/0.007433, allocations: 153 kB / 0.4988 GB, free: 4.996 MB / 366.1 MB Notification: Performance of [INI] Inline: time 0.0002546/0.007688, allocations: 275.7 kB / 0.499 GB, free: 4.723 MB / 366.1 MB Notification: Performance of [INI] Partitioning: time 1.736e-05/0.007705, allocations: 12.12 kB / 0.499 GB, free: 4.703 MB / 366.1 MB Notification: Performance of [INI] Cleanup: time 4.107e-05/0.007746, allocations: 35.98 kB / 0.4991 GB, free: 4.668 MB / 366.1 MB Notification: Performance of [INI] Causalize: time 0.0004288/0.008175, allocations: 318.3 kB / 0.4994 GB, free: 4.352 MB / 366.1 MB Notification: Performance of [INI] Tearing: time 1.611e-05/0.008191, allocations: 12 kB / 0.4994 GB, free: 4.34 MB / 366.1 MB Notification: Performance of [SIM] Initialization: time 4.21e-07/0.008192, allocations: 0 / 0.4994 GB, free: 4.34 MB / 366.1 MB Notification: Performance of [SIM] DAE-Mode: time 9.735e-05/0.008289, allocations: 56.02 kB / 0.4994 GB, free: 4.277 MB / 366.1 MB Notification: Performance of [SIM] Remove Dummies: time 4.077e-06/0.008293, allocations: 0 / 0.4994 GB, free: 4.277 MB / 366.1 MB Notification: Performance of [SIM] Tearing: time 1.968e-05/0.008313, allocations: 27.94 kB / 0.4995 GB, free: 4.25 MB / 366.1 MB Notification: Performance of [SIM] Categorize: time 6.142e-06/0.008319, allocations: 0 / 0.4995 GB, free: 4.25 MB / 366.1 MB Notification: Performance of [SIM] Solve: time 0.0002203/0.008539, allocations: 135.9 kB / 0.4996 GB, free: 4.117 MB / 366.1 MB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref demux3.y[3] is neither a seed nor a partial candidate! " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 2.7538051839801483] Failed to read output from testmodel.py, exit status != 0: ['time', 'y1', 'y2', 'y3', 'y4', 'y5', 'clock.y', 'mux5.y[1]', 'mux5.y[2]', 'mux5.y[3]', 'mux5.y[4]', 'mux5.y[5]', 'demux5.y[1]', 'demux5.y[2]', 'demux5.y[3]', 'demux5.y[4]', 'demux5.y[5]', 'mux3.y[1]', 'mux3.y[2]', 'mux3.y[3]', 'mux2.y[1]', 'mux2.y[2]', 'demux2.y[1]', 'demux2.y[2]', 'demux3.y[1]', 'demux3.y[2]', 'demux3.y[3]'] 0.016883156029507518 0.030561590000000003 0.02344776 Calling exit ...