Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.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.001506/0.001506, 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.001672/0.001672, allocations: 216.1 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.335/1.335, allocations: 230.7 MB / 256.9 MB, free: 7.734 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.535/2.535, allocations: 476 MB / 0.7708 GB, free: 4.637 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.UnbalancedStepDown.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.UnbalancedStepDown.YY") translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.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.UnbalancedStepDown.YY") [Timeout 300] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.654e-05/1.654e-05, allocations: 4.672 kB / 1.118 GB, free: 41.12 MB / 0.9044 GB Notification: Performance of NFInst.instantiate(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepDown.YY): time 0.01721/0.01723, allocations: 19.34 MB / 1.137 GB, free: 33.14 MB / 0.9044 GB Notification: Performance of NFInst.instExpressions: time 0.00892/0.02615, allocations: 7.17 MB / 1.144 GB, free: 28.55 MB / 0.9044 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.0009495/0.0271, allocations: 71.12 kB / 1.144 GB, free: 28.53 MB / 0.9044 GB Notification: Performance of NFTyping.typeComponents: time 0.00369/0.03079, allocations: 1.898 MB / 1.146 GB, free: 27.51 MB / 0.9044 GB Notification: Performance of NFTyping.typeBindings: time 0.002611/0.0334, allocations: 1.579 MB / 1.147 GB, free: 26.63 MB / 0.9044 GB Notification: Performance of NFTyping.typeClassSections: time 0.002415/0.03582, allocations: 1.308 MB / 1.149 GB, free: 25.93 MB / 0.9044 GB Notification: Performance of NFFlatten.flatten: time 0.005026/0.04084, allocations: 5.178 MB / 1.154 GB, free: 23.81 MB / 0.9044 GB Notification: Performance of NFFlatten.resolveConnections: time 0.003424/0.04427, allocations: 2.511 MB / 1.156 GB, free: 22.4 MB / 0.9044 GB Notification: Performance of NFEvalConstants.evaluate: time 0.003646/0.04791, allocations: 2.022 MB / 1.158 GB, free: 21.55 MB / 0.9044 GB Notification: Performance of NFSimplifyModel.simplify: time 0.003732/0.05164, allocations: 1.898 MB / 1.16 GB, free: 20.84 MB / 0.9044 GB Notification: Performance of NFPackage.collectConstants: time 0.0005643/0.05221, allocations: 314.9 kB / 1.16 GB, free: 20.84 MB / 0.9044 GB Notification: Performance of NFFlatten.collectFunctions: time 0.002286/0.05449, allocations: 0.8963 MB / 1.161 GB, free: 20.61 MB / 0.9044 GB Notification: Performance of combineBinaries: time 0.00458/0.05907, allocations: 4.832 MB / 1.166 GB, free: 17.67 MB / 0.9044 GB Notification: Performance of replaceArrayConstructors: time 0.00235/0.06142, allocations: 2.712 MB / 1.169 GB, free: 15.97 MB / 0.9044 GB Notification: Performance of NFVerifyModel.verify: time 0.0006892/0.06211, allocations: 150.8 kB / 1.169 GB, free: 15.97 MB / 0.9044 GB Notification: Performance of FrontEnd: time 0.0003458/0.06246, allocations: 40.06 kB / 1.169 GB, free: 15.96 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: 1094 (523) * Number of variables: 1094 (377) Notification: Performance of [SIM] Bindings: time 0.01207/0.07453, allocations: 12.92 MB / 1.181 GB, free: 8.105 MB / 0.9044 GB Notification: Performance of [SIM] FunctionAlias: time 0.002156/0.07669, allocations: 1.864 MB / 1.183 GB, free: 7.023 MB / 0.9044 GB Notification: Performance of [SIM] Early Inline: time 0.02308/0.09977, allocations: 19.69 MB / 1.202 GB, free: 13.55 MB / 0.92 GB Notification: Performance of [SIM] Simplify 1: time 0.007354/0.1071, allocations: 3.807 MB / 1.206 GB, free: 11.88 MB / 0.92 GB Notification: Performance of [SIM] Alias: time 0.01923/0.1264, allocations: 11.87 MB / 1.218 GB, free: 5.383 MB / 0.92 GB Notification: Performance of [SIM] Simplify 2: time 0.005816/0.1322, allocations: 3.589 MB / 1.221 GB, free: 3.773 MB / 0.92 GB Notification: Performance of [SIM] Remove Stream: time 0.001628/0.1338, allocations: 1.052 MB / 1.222 GB, free: 2.934 MB / 0.92 GB Notification: Performance of [SIM] Detect States: time 0.003161/0.137, allocations: 2.744 MB / 1.225 GB, free: 0.582 MB / 0.92 GB Notification: Performance of [SIM] Events: time 0.001955/0.1389, allocations: 1.369 MB / 1.226 GB, free: 15.69 MB / 0.9356 GB Notification: Performance of [SIM] Partitioning: time 0.00617/0.1451, allocations: 5.186 MB / 1.231 GB, free: 12.45 MB / 0.9356 GB Notification: Performance of [SIM] Causalize: time 0.02423/0.1693, allocations: 16.37 MB / 1.247 GB, free: 0.6055 MB / 0.9356 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.01555/0.1849, allocations: 13.33 MB / 1.26 GB, free: 3.254 MB / 0.9512 GB Notification: Performance of [INI] Simplify: time 0.009584/0.1944, allocations: 5.874 MB / 1.266 GB, free: 13.32 MB / 0.9669 GB Notification: Performance of [INI] Inline: time 0.0243/0.2187, allocations: 22.37 MB / 1.288 GB, free: 6.895 MB / 0.9825 GB Notification: Performance of [INI] Partitioning: time 0.0006799/0.2194, allocations: 155.5 kB / 1.288 GB, free: 6.707 MB / 0.9825 GB Notification: Performance of [INI] Cleanup: time 0.005781/0.2252, allocations: 3.88 MB / 1.292 GB, free: 2.793 MB / 0.9825 GB Notification: Performance of [INI] Causalize: time 0.04906/0.2743, allocations: 30.73 MB / 1.322 GB, free: 3.656 MB / 1.014 GB Notification: Performance of [INI] Tearing: time 0.002469/0.2767, allocations: 1.915 MB / 1.324 GB, free: 1.785 MB / 1.014 GB Notification: Performance of [SIM] Initialization: time 4.018e-06/0.2767, allocations: 4 kB / 1.324 GB, free: 1.781 MB / 1.014 GB Notification: Performance of [SIM] DAE-Mode: time 0.007473/0.2842, allocations: 5.088 MB / 1.329 GB, free: 12.69 MB / 1.029 GB Notification: Performance of [SIM] Remove Dummies: time 1.994e-05/0.2842, allocations: 3 kB / 1.329 GB, free: 12.69 MB / 1.029 GB Notification: Performance of [SIM] Tearing: time 0.001992/0.2862, allocations: 1.701 MB / 1.33 GB, free: 11.01 MB / 1.029 GB Notification: Performance of [SIM] Categorize: time 6.13e-05/0.2863, allocations: 15.98 kB / 1.33 GB, free: 10.99 MB / 1.029 GB Notification: Performance of [SIM] Solve: time 0.03734/0.3236, allocations: 25.89 MB / 1.356 GB, free: 1.414 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.055958495999221] Failed to read output from testmodel.py, exit status != 0: 0.7620344309834763 0.35226848800000005 0.286884276 Calling exit ...