Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.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.00146/0.00146, 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.001555/0.001555, allocations: 215.8 kB / 23.06 MB, free: 4.848 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.321/1.321, allocations: 230.7 MB / 256.9 MB, free: 7.766 MB / 206.1 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo): time 2.554/2.554, allocations: 476 MB / 0.7708 GB, free: 4.66 MB / 0.6231 GB " [Timeout remaining time 177] Using package Buildings with version 11.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.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.BalancedStepDown.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_11_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YY") translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.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_11_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YY") [Timeout 300] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.605e-05/1.605e-05, allocations: 3.969 kB / 1.118 GB, free: 41.06 MB / 0.9044 GB Notification: Performance of NFInst.instantiate(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YY): time 0.01699/0.017, allocations: 19.25 MB / 1.137 GB, free: 33.27 MB / 0.9044 GB Notification: Performance of NFInst.instExpressions: time 0.009215/0.02622, allocations: 7.15 MB / 1.144 GB, free: 28.7 MB / 0.9044 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.00132/0.02754, allocations: 66.41 kB / 1.144 GB, free: 28.68 MB / 0.9044 GB Notification: Performance of NFTyping.typeComponents: time 0.004114/0.03165, allocations: 1.892 MB / 1.146 GB, free: 27.67 MB / 0.9044 GB Notification: Performance of NFTyping.typeBindings: time 0.00314/0.03479, allocations: 1.552 MB / 1.147 GB, free: 26.8 MB / 0.9044 GB Notification: Performance of NFTyping.typeClassSections: time 0.002687/0.03748, allocations: 1.315 MB / 1.149 GB, free: 26.1 MB / 0.9044 GB Notification: Performance of NFFlatten.flatten: time 0.004502/0.04198, allocations: 5.129 MB / 1.154 GB, free: 24.01 MB / 0.9044 GB Notification: Performance of NFFlatten.resolveConnections: time 0.003226/0.04521, allocations: 2.464 MB / 1.156 GB, free: 22.64 MB / 0.9044 GB Notification: Performance of NFEvalConstants.evaluate: time 0.002934/0.04814, allocations: 1.999 MB / 1.158 GB, free: 21.81 MB / 0.9044 GB Notification: Performance of NFSimplifyModel.simplify: time 0.002842/0.05099, allocations: 1.886 MB / 1.16 GB, free: 21.09 MB / 0.9044 GB Notification: Performance of NFPackage.collectConstants: time 0.0004656/0.05145, allocations: 316.4 kB / 1.16 GB, free: 21.09 MB / 0.9044 GB Notification: Performance of NFFlatten.collectFunctions: time 0.001885/0.05334, allocations: 0.8888 MB / 1.161 GB, free: 20.87 MB / 0.9044 GB Notification: Performance of combineBinaries: time 0.003958/0.05729, allocations: 4.752 MB / 1.166 GB, free: 17.98 MB / 0.9044 GB Notification: Performance of replaceArrayConstructors: time 0.002184/0.05948, allocations: 2.653 MB / 1.168 GB, free: 16.32 MB / 0.9044 GB Notification: Performance of NFVerifyModel.verify: time 0.0006203/0.0601, allocations: 145.8 kB / 1.168 GB, free: 16.32 MB / 0.9044 GB Notification: Performance of FrontEnd: time 0.0003057/0.0604, allocations: 41.27 kB / 1.168 GB, free: 16.31 MB / 0.9044 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1083 (512) * Number of variables: 1083 (366) Notification: Performance of [SIM] Bindings: time 0.01196/0.07236, allocations: 12.7 MB / 1.181 GB, free: 8.641 MB / 0.9044 GB Notification: Performance of [SIM] FunctionAlias: time 0.002271/0.07463, allocations: 1.875 MB / 1.183 GB, free: 7.523 MB / 0.9044 GB Notification: Performance of [SIM] Early Inline: time 0.02261/0.09724, allocations: 19.61 MB / 1.202 GB, free: 14.1 MB / 0.92 GB Notification: Performance of [SIM] Simplify 1: time 0.006807/0.104, allocations: 3.793 MB / 1.205 GB, free: 12.43 MB / 0.92 GB Notification: Performance of [SIM] Alias: time 0.01771/0.1218, allocations: 11.68 MB / 1.217 GB, free: 6.004 MB / 0.92 GB Notification: Performance of [SIM] Simplify 2: time 0.005486/0.1272, allocations: 3.595 MB / 1.22 GB, free: 4.48 MB / 0.92 GB Notification: Performance of [SIM] Remove Stream: time 0.00169/0.1289, allocations: 1.058 MB / 1.221 GB, free: 3.672 MB / 0.92 GB Notification: Performance of [SIM] Detect States: time 0.002865/0.1318, allocations: 2.703 MB / 1.224 GB, free: 1.352 MB / 0.92 GB Notification: Performance of [SIM] Events: time 0.001861/0.1337, allocations: 1.403 MB / 1.225 GB, free: 444 kB / 0.92 GB Notification: Performance of [SIM] Partitioning: time 0.005995/0.1397, allocations: 5.191 MB / 1.23 GB, free: 13.2 MB / 0.9356 GB Notification: Performance of [SIM] Causalize: time 0.02475/0.1644, allocations: 16.37 MB / 1.246 GB, free: 1.617 MB / 0.9356 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.01611/0.1805, allocations: 13.35 MB / 1.259 GB, free: 4.254 MB / 0.9512 GB Notification: Performance of [INI] Simplify: time 0.01058/0.1911, allocations: 5.787 MB / 1.265 GB, free: 14.41 MB / 0.9669 GB Notification: Performance of [INI] Inline: time 0.02731/0.2184, allocations: 22.33 MB / 1.287 GB, free: 8.027 MB / 0.9825 GB Notification: Performance of [INI] Partitioning: time 0.0008479/0.2192, allocations: 163.2 kB / 1.287 GB, free: 7.832 MB / 0.9825 GB Notification: Performance of [INI] Cleanup: time 0.00663/0.2259, allocations: 3.86 MB / 1.291 GB, free: 3.938 MB / 0.9825 GB Notification: Performance of [INI] Causalize: time 0.04968/0.2756, allocations: 30.66 MB / 1.321 GB, free: 4.871 MB / 1.014 GB Notification: Performance of [INI] Tearing: time 0.002371/0.2779, allocations: 1.916 MB / 1.323 GB, free: 3 MB / 1.014 GB Notification: Performance of [SIM] Initialization: time 1.773e-06/0.2779, allocations: 0 / 1.323 GB, free: 3 MB / 1.014 GB Notification: Performance of [SIM] DAE-Mode: time 0.007399/0.2853, allocations: 5.087 MB / 1.328 GB, free: 13.9 MB / 1.029 GB Notification: Performance of [SIM] Remove Dummies: time 2.078e-05/0.2853, allocations: 3 kB / 1.328 GB, free: 13.89 MB / 1.029 GB Notification: Performance of [SIM] Tearing: time 0.002042/0.2874, allocations: 1.704 MB / 1.329 GB, free: 12.22 MB / 1.029 GB Notification: Performance of [SIM] Categorize: time 7.752e-05/0.2875, allocations: 15.94 kB / 1.329 GB, free: 12.2 MB / 1.029 GB Notification: Performance of [SIM] Solve: time 0.03728/0.3248, allocations: 25.7 MB / 1.354 GB, free: 2.809 MB / 1.045 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 299] [Calling sys.exit(0), Time elapsed: 6.026603400998283] Failed to read output from testmodel.py, exit status != 0: 0.7553503170493059 0.35397726199999996 0.29047398799999996 Calling exit ...