Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY.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.001617/0.001617, 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.00159/0.00159, allocations: 217.8 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.288/1.288, allocations: 230.6 MB / 256.9 MB, free: 7.773 MB / 206.1 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.802/2.802, allocations: 0.4893 GB / 0.7952 GB, free: 35.6 MB / 0.6231 GB " [Timeout remaining time 177] Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/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(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|err_V2.1.|err_V2.2.|err_V2.3.|err_V3.1.|err_V3.2.|err_V3.3.|err_V4.1.|err_V4.2.|err_V4.3.|err_Theta2.1.|err_Theta2.2.|err_Theta2.3.|err_Theta3.1.|err_Theta3.2.|err_Theta3.3.|err_Theta4.1.|err_Theta4.2.|err_Theta4.3.",fileNamePrefix="Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY") translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|err_V2.1.|err_V2.2.|err_V2.3.|err_V3.1.|err_V3.2.|err_V3.3.|err_V4.1.|err_V4.2.|err_V4.3.|err_Theta2.1.|err_Theta2.2.|err_Theta2.3.|err_Theta3.1.|err_Theta3.2.|err_Theta3.3.|err_Theta4.1.|err_Theta4.2.|err_Theta4.3.",fileNamePrefix="Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY") [Timeout 300] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.483e-05/1.483e-05, allocations: 2.281 kB / 1.155 GB, free: 25.52 MB / 0.9044 GB Notification: Performance of NFInst.instantiate(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY): time 0.01843/0.01844, allocations: 19.34 MB / 1.173 GB, free: 13.64 MB / 0.9044 GB Notification: Performance of NFInst.instExpressions: time 0.01015/0.02859, allocations: 7.073 MB / 1.18 GB, free: 9.102 MB / 0.9044 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001531/0.03012, allocations: 68.19 kB / 1.18 GB, free: 9.086 MB / 0.9044 GB Notification: Performance of NFTyping.typeComponents: time 0.003988/0.03411, allocations: 1.912 MB / 1.182 GB, free: 8.035 MB / 0.9044 GB Notification: Performance of NFTyping.typeBindings: time 0.003335/0.03744, allocations: 1.54 MB / 1.184 GB, free: 7.164 MB / 0.9044 GB Notification: Performance of NFTyping.typeClassSections: time 0.002864/0.04031, allocations: 1.302 MB / 1.185 GB, free: 6.469 MB / 0.9044 GB Notification: Performance of NFFlatten.flatten: time 0.005461/0.04577, allocations: 5.16 MB / 1.19 GB, free: 4.289 MB / 0.9044 GB Notification: Performance of NFFlatten.resolveConnections: time 0.003414/0.04918, allocations: 2.513 MB / 1.193 GB, free: 2.863 MB / 0.9044 GB Notification: Performance of NFEvalConstants.evaluate: time 0.003023/0.05221, allocations: 2.021 MB / 1.194 GB, free: 2.02 MB / 0.9044 GB Notification: Performance of NFSimplifyModel.simplify: time 0.002559/0.05476, allocations: 1.9 MB / 1.196 GB, free: 1.293 MB / 0.9044 GB Notification: Performance of NFPackage.collectConstants: time 0.0004164/0.05518, allocations: 318.1 kB / 1.197 GB, free: 1.289 MB / 0.9044 GB Notification: Performance of NFFlatten.collectFunctions: time 0.00176/0.05694, allocations: 0.8646 MB / 1.197 GB, free: 1.078 MB / 0.9044 GB Notification: Performance of combineBinaries: time 0.004369/0.06131, allocations: 4.822 MB / 1.202 GB, free: 14.14 MB / 0.92 GB Notification: Performance of replaceArrayConstructors: time 0.002673/0.06398, allocations: 2.71 MB / 1.205 GB, free: 12.44 MB / 0.92 GB Notification: Performance of NFVerifyModel.verify: time 0.0005844/0.06457, allocations: 149.7 kB / 1.205 GB, free: 12.44 MB / 0.92 GB Notification: Performance of FrontEnd: time 0.0003285/0.0649, allocations: 40.66 kB / 1.205 GB, free: 12.43 MB / 0.92 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1094 (523) * Number of variables: 1094 (377) Notification: Performance of [SIM] Bindings: time 0.01423/0.07913, allocations: 12.9 MB / 1.218 GB, free: 4.586 MB / 0.92 GB Notification: Performance of [SIM] FunctionAlias: time 0.002291/0.08142, allocations: 1.877 MB / 1.219 GB, free: 3.477 MB / 0.92 GB Notification: Performance of [SIM] Early Inline: time 0.02335/0.1048, allocations: 19.69 MB / 1.239 GB, free: 8.047 MB / 0.9356 GB Notification: Performance of [SIM] Simplify 1: time 0.005974/0.1107, allocations: 3.788 MB / 1.242 GB, free: 5.918 MB / 0.9356 GB Notification: Performance of [SIM] Alias: time 0.0149/0.1256, allocations: 11.88 MB / 1.254 GB, free: 11.54 MB / 0.9512 GB Notification: Performance of [SIM] Simplify 2: time 0.004794/0.1304, allocations: 3.583 MB / 1.257 GB, free: 8.191 MB / 0.9512 GB Notification: Performance of [SIM] Remove Stream: time 0.001254/0.1317, allocations: 1.051 MB / 1.259 GB, free: 7.086 MB / 0.9512 GB Notification: Performance of [SIM] Detect States: time 0.002666/0.1344, allocations: 2.742 MB / 1.261 GB, free: 4.25 MB / 0.9512 GB Notification: Performance of [SIM] Events: time 0.001624/0.136, allocations: 1.365 MB / 1.263 GB, free: 2.965 MB / 0.9512 GB Notification: Performance of [SIM] Partitioning: time 0.005594/0.1416, allocations: 5.19 MB / 1.268 GB, free: 13.69 MB / 0.9669 GB Notification: Performance of [SIM] Causalize: time 0.02375/0.1653, allocations: 16.37 MB / 1.284 GB, free: 13.04 MB / 0.9825 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.01409/0.1794, allocations: 13.34 MB / 1.297 GB, free: 15.69 MB / 0.9981 GB Notification: Performance of [INI] Simplify: time 0.008315/0.1877, allocations: 5.877 MB / 1.302 GB, free: 9.77 MB / 0.9981 GB Notification: Performance of [INI] Inline: time 0.02183/0.2096, allocations: 22.36 MB / 1.324 GB, free: 3.363 MB / 1.014 GB Notification: Performance of [INI] Partitioning: time 0.0005028/0.2101, allocations: 167.5 kB / 1.324 GB, free: 3.156 MB / 1.014 GB Notification: Performance of [INI] Cleanup: time 0.004762/0.2148, allocations: 3.872 MB / 1.328 GB, free: 15.26 MB / 1.029 GB Notification: Performance of [INI] Causalize: time 0.04239/0.2572, allocations: 30.72 MB / 1.358 GB, free: 128 kB / 1.045 GB Notification: Performance of [INI] Tearing: time 0.002079/0.2593, allocations: 1.929 MB / 1.36 GB, free: 14.24 MB / 1.061 GB Notification: Performance of [SIM] Initialization: time 1.653e-06/0.2593, allocations: 0 / 1.36 GB, free: 14.24 MB / 1.061 GB Notification: Performance of [SIM] DAE-Mode: time 0.007001/0.2663, allocations: 5.084 MB / 1.365 GB, free: 9.148 MB / 1.061 GB Notification: Performance of [SIM] Remove Dummies: time 2.33e-05/0.2663, allocations: 11 kB / 1.365 GB, free: 9.137 MB / 1.061 GB Notification: Performance of [SIM] Tearing: time 0.001831/0.2681, allocations: 1.694 MB / 1.367 GB, free: 7.469 MB / 1.061 GB Notification: Performance of [SIM] Categorize: time 4.913e-05/0.2682, allocations: 16 kB / 1.367 GB, free: 7.453 MB / 1.061 GB Notification: Performance of [SIM] Solve: time 0.03364/0.3018, allocations: 25.87 MB / 1.392 GB, free: 13.9 MB / 1.092 GB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref node4.term.phase[1].i[1] is neither a seed nor a partial candidate! " [Timeout remaining time 300] [Calling sys.exit(0), Time elapsed: 5.856005273992196] Failed to read output from testmodel.py, exit status != 0: 0.3151641589938663 0.32821540199999993 0.260508916 Calling exit ...