Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IndustrialControlSystems_IndustrialControlSystems.Controllers.Examples.TestPID_bias.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.001357/0.001357, allocations: 104.3 kB / 19.76 MB, free: 1.906 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.001456/0.001456, allocations: 214 kB / 23.06 MB, free: 4.984 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.428/1.428, allocations: 230.7 MB / 256.9 MB, free: 7.766 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IndustrialControlSystems 2.0.0/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IndustrialControlSystems 2.0.0/package.mo): time 0.06201/0.06201, allocations: 11.35 MB / 324.6 MB, free: 7.996 MB / 254.1 MB " [Timeout remaining time 180] Using package IndustrialControlSystems with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IndustrialControlSystems 2.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(IndustrialControlSystems.Controllers.Examples.TestPID_bias,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IndustrialControlSystems_IndustrialControlSystems.Controllers.Examples.TestPID_bias") translateModel(IndustrialControlSystems.Controllers.Examples.TestPID_bias,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IndustrialControlSystems_IndustrialControlSystems.Controllers.Examples.TestPID_bias") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.345e-05/2.345e-05, allocations: 2.281 kB / 452.3 MB, free: 9.84 MB / 318.1 MB Notification: Performance of NFInst.instantiate(IndustrialControlSystems.Controllers.Examples.TestPID_bias): time 0.003673/0.003696, allocations: 2.153 MB / 454.4 MB, free: 7.672 MB / 318.1 MB Notification: Performance of NFInst.instExpressions: time 0.001413/0.00511, allocations: 0.7027 MB / 455.1 MB, free: 6.969 MB / 318.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0001892/0.005299, allocations: 27.69 kB / 455.2 MB, free: 6.941 MB / 318.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0002307/0.00553, allocations: 67.31 kB / 455.2 MB, free: 6.875 MB / 318.1 MB Notification: Performance of NFTyping.typeBindings: time 0.0002082/0.005738, allocations: 51.48 kB / 455.3 MB, free: 6.824 MB / 318.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.0007221/0.00646, allocations: 363.3 kB / 455.6 MB, free: 6.469 MB / 318.1 MB Notification: Performance of NFFlatten.flatten: time 0.0009131/0.007373, allocations: 0.8863 MB / 456.5 MB, free: 5.582 MB / 318.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0002296/0.007603, allocations: 81.12 kB / 456.6 MB, free: 5.496 MB / 318.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0005146/0.008117, allocations: 383 kB / 457 MB, free: 5.121 MB / 318.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0002541/0.008371, allocations: 187 kB / 457.2 MB, free: 4.938 MB / 318.1 MB Notification: Performance of NFPackage.collectConstants: time 6.28e-05/0.008434, allocations: 32 kB / 457.2 MB, free: 4.906 MB / 318.1 MB Notification: Performance of NFFlatten.collectFunctions: time 6.052e-05/0.008495, allocations: 32 kB / 457.2 MB, free: 4.875 MB / 318.1 MB Notification: Performance of combineBinaries: time 0.0006487/0.009143, allocations: 0.7958 MB / 458 MB, free: 4.07 MB / 318.1 MB Notification: Performance of replaceArrayConstructors: time 0.0003603/0.009504, allocations: 0.528 MB / 458.5 MB, free: 3.535 MB / 318.1 MB Notification: Performance of NFVerifyModel.verify: time 5.064e-05/0.009554, allocations: 20 kB / 458.6 MB, free: 3.516 MB / 318.1 MB Notification: Performance of FrontEnd: time 6.307e-05/0.009617, allocations: 31.8 kB / 458.6 MB, free: 3.484 MB / 318.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 100 (94) * Number of variables: 100 (82) Notification: Performance of [SIM] Bindings: time 0.002453/0.01207, allocations: 1.977 MB / 460.6 MB, free: 1.371 MB / 318.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.0003721/0.01244, allocations: 275.8 kB / 460.8 MB, free: 1.082 MB / 318.1 MB Notification: Performance of [SIM] Early Inline: time 0.001089/0.01353, allocations: 0.9876 MB / 461.8 MB, free: 68 kB / 318.1 MB Notification: Performance of [SIM] Simplify 1: time 0.0004697/0.014, allocations: 280.3 kB / 462.1 MB, free: 15.74 MB / 334.1 MB Notification: Performance of [SIM] Alias: time 0.00226/0.01626, allocations: 1.49 MB / 463.6 MB, free: 14.03 MB / 334.1 MB Notification: Performance of [SIM] Simplify 2: time 0.0003281/0.01659, allocations: 226 kB / 463.8 MB, free: 13.76 MB / 334.1 MB Notification: Performance of [SIM] Remove Stream: time 0.0001558/0.01674, allocations: 112.3 kB / 463.9 MB, free: 13.62 MB / 334.1 MB Notification: Performance of [SIM] Detect States: time 0.0004476/0.01719, allocations: 301.1 kB / 464.2 MB, free: 13.27 MB / 334.1 MB Notification: Performance of [SIM] Events: time 0.0001035/0.0173, allocations: 47.81 kB / 464.3 MB, free: 13.22 MB / 334.1 MB Notification: Performance of [SIM] Partitioning: time 0.0004529/0.01775, allocations: 352.5 kB / 464.6 MB, free: 12.87 MB / 334.1 MB Error: Internal error NBResolveSingularities.indexReduction failed because there was not enough state candidates to balance out the constraint equations. Constraint Equations (39/45) ****************************** (1) [SCAL] (1) R.SP = SPstep.offset + (if $TEV_0 then 0.0 else SPstep.height) ($RES_SIM_89) (2) [SCAL] (1) R.Paction = 10.0 * (R.SP - ProcessCtrl.y) ($RES_SIM_88) (3) [SCAL] (1) 0.0 = 2.0 * (R.SP - ProcessCtrl.y) + 0.01 * R.satDiff ($RES_SIM_86) (4) [SCAL] (1) sub1.y = R.SP - R_Bias.bias ($RES_SIM_4) (5) [SCAL] (1) R.Daction = 100.0 * (R.SP - ProcessCtrl.y) - R.Fder ($RES_SIM_84) (6) [SCAL] (1) ProcessBias.b[:] * ProcessBias.Y[:] = ProcessBias.c[:] * ProcessBias.U[:] ($RES_SIM_5) (7) [SCAL] (1) R.Fder = 100.0 * (R.SP - ProcessCtrl.y) - 0.05 * 0.0 ($RES_SIM_83) (8) [SCAL] (1) ProcessBias.y = ProcessBias.A * sub3.y + ProcessBias.w ($RES_SIM_6) (9) [SCAL] (1) ProcessBias.U[1] = sub3.y ($RES_SIM_8) (10) [SCAL] (1) sub2.y = R.CS - R_Bias.bias ($RES_SIM_65) (11) [SCAL] (1) R_Bias.Paction = 10.0 * (R.SP - ProcessBias.y) ($RES_SIM_64) (12) [SCAL] (1) 0.0 = 2.0 * (R.SP - ProcessBias.y) + 0.01 * R_Bias.satDiff ($RES_SIM_62) (13) [SCAL] (1) R_Bias.Daction = 100.0 * (R.SP - ProcessBias.y) - R_Bias.Fder ($RES_SIM_60) (14) [SCAL] (1) ProcessCtrl.b[:] * ProcessCtrl.Y[:] = ProcessCtrl.c[:] * ProcessCtrl.U[:] ($RES_SIM_29) (15) [ARRY] (2) processNoCtrl.a[2:3] = processNoCtrl.num[:] ($RES_SIM_27) (16) [SCAL] (1) sub3.y = R_Bias.CS - R_Bias.bias ($RES_SIM_42) (17) [SCAL] (1) processNoCtrl.A = processNoCtrl.a[1] / processNoCtrl.b[1] ($RES_SIM_26) (18) [SCAL] (1) R_Bias.bias = Disturbance.offset + (if $TEV_1 then 0.0 else Disturbance.height) ($RES_SIM_41) (19) [FOR-] (2) ($RES_SIM_24) (19) [----] for $i1 in 1:2 loop (19) [----] [SCAL] (1) processNoCtrl.c[$i1] = processNoCtrl.a[1 + $i1] - processNoCtrl.A * processNoCtrl.b[1 + $i1] ($RES_SIM_25) (19) [----] end for; (20) [SCAL] (1) processNoCtrl.Y[2] = processNoCtrl.w ($RES_SIM_22) (21) [SCAL] (1) processNoCtrl.U[1] = sub1.y ($RES_SIM_20) (22) [SCAL] (1) ProcessBias.a[1] = 0.0 ($RES_SIM_107) (23) [SCAL] (1) processNoCtrl.a[1] = 0.0 ($RES_SIM_106) (24) [SCAL] (1) R_Bias.Fder = 100.0 * (R.SP - ProcessBias.y) - 0.05 * 0.0 ($RES_SIM_59) (25) [SCAL] (1) ProcessCtrl.a[1] = 0.0 ($RES_SIM_105) (26) [SCAL] (1) R_Bias.cs = max(0.0, min(2.0, R_Bias.satin)) ($RES_SIM_57) (27) [SCAL] (1) R_Bias.CS = max(0.0, min(2.0, R_Bias.cs + R_Bias.bias)) ($RES_SIM_55) (28) [ARRY] (2) ProcessCtrl.a[2:3] = ProcessCtrl.num[:] ($RES_SIM_39) (29) [SCAL] (1) ProcessCtrl.A = ProcessCtrl.a[1] / ProcessCtrl.b[1] ($RES_SIM_38) (30) [FOR-] (2) ($RES_SIM_36) (30) [----] for $i1 in 1:2 loop (30) [----] [SCAL] (1) ProcessCtrl.c[$i1] = ProcessCtrl.a[1 + $i1] - ProcessCtrl.A * ProcessCtrl.b[1 + $i1] ($RES_SIM_37) (30) [----] end for; (31) [SCAL] (1) ProcessCtrl.Y[2] = ProcessCtrl.w ($RES_SIM_34) (32) [SCAL] (1) processNoCtrl.y = processNoCtrl.A * sub1.y + processNoCtrl.w ($RES_SIM_18) (33) [SCAL] (1) processNoCtrl.b[:] * processNoCtrl.Y[:] = processNoCtrl.c[:] * processNoCtrl.U[:] ($RES_SIM_17) (34) [SCAL] (1) ProcessCtrl.U[1] = sub2.y ($RES_SIM_32) (35) [ARRY] (2) ProcessBias.a[2:3] = ProcessBias.num[:] ($RES_SIM_15) (36) [SCAL] (1) ProcessCtrl.y = ProcessCtrl.A * sub2.y + ProcessCtrl.w ($RES_SIM_30) (37) [SCAL] (1) ProcessBias.A = ProcessBias.a[1] / ProcessBias.b[1] ($RES_SIM_14) (38) [FOR-] (2) ($RES_SIM_12) (38) [----] for $i1 in 1:2 loop (38) [----] [SCAL] (1) ProcessBias.c[$i1] = ProcessBias.a[1 + $i1] - ProcessBias.A * ProcessBias.b[1 + $i1] ($RES_SIM_13) (38) [----] end for; (39) [SCAL] (1) ProcessBias.Y[2] = ProcessBias.w ($RES_SIM_10) State Candidate Variables (26/44) *********************************** (1) [STAT] (2) protected Real[2] ProcessCtrl.U (2) [ALGB] (1) Real R.SP (3) [ALGB] (2) protected Real[2] ProcessBias.c (4) [ALGB] (3) protected Real[3] ProcessCtrl.a (5) [ALGB] (1) Real ProcessCtrl.y (6) [ALGB] (3) protected Real[3] processNoCtrl.a (7) [ALGB] (1) Real sub3.y (8) [ALGB] (1) Real sub2.y (9) [STAT] (3) protected Real[3] ProcessBias.Y (10) [ALGB] (1) Real sub1.y (11) [ALGB] (1) Real processNoCtrl.y (12) [ALGB] (2) protected Real[2] ProcessCtrl.c (13) [STAT] (1) protected Real ProcessBias.w (14) [ALGB] (1) protected Real processNoCtrl.A (15) [ALGB] (1) protected Real ProcessBias.A (16) [STAT] (2) protected Real[2] ProcessBias.U (17) [ALGB] (2) protected Real[2] processNoCtrl.c (18) [STAT] (3) protected Real[3] ProcessCtrl.Y (19) [ALGB] (3) protected Real[3] ProcessBias.a (20) [STAT] (1) protected Real processNoCtrl.w (21) [ALGB] (1) Real ProcessBias.y (22) [ALGB] (1) Real R_Bias.bias (23) [STAT] (3) protected Real[3] processNoCtrl.Y (24) [STAT] (1) protected Real ProcessCtrl.w (25) [STAT] (2) protected Real[2] processNoCtrl.U (26) [ALGB] (1) protected Real ProcessCtrl.A " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 2.434811494022142] Failed to read output from testmodel.py, exit status != 0: 0.027389394002966583 0.041838857 0.029244621000000002 Calling exit ...