Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay.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.00149/0.00149, 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.001621/0.001621, allocations: 212.6 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.324/1.324, allocations: 230.7 MB / 256.9 MB, free: 7.777 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.882/2.882, allocations: 0.4893 GB / 0.7952 GB, free: 35.59 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.Controls.OBC.CDL.Logical.Validation.TrueDelay,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|onDelay0.u|onDelay0.y|onDelay1.y|onDelay2.y|onDelay3.y|onDelay4.y|onDelay5.y|onDelay6.y|onDelay7.y|onDelay00.u|onDelay00.y|onDelay11.y|onDelay22.y|onDelay33.y|onDelay44.y|onDelay55.y|onDelay66.y|onDelay77.y",fileNamePrefix="Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay") translateModel(Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|onDelay0.u|onDelay0.y|onDelay1.y|onDelay2.y|onDelay3.y|onDelay4.y|onDelay5.y|onDelay6.y|onDelay7.y|onDelay00.u|onDelay00.y|onDelay11.y|onDelay22.y|onDelay33.y|onDelay44.y|onDelay55.y|onDelay66.y|onDelay77.y",fileNamePrefix="Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay") [Timeout 300] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.244e-05/1.244e-05, allocations: 2.281 kB / 1.154 GB, free: 25.53 MB / 0.9044 GB Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay): time 0.001753/0.001765, allocations: 1.112 MB / 1.156 GB, free: 24.84 MB / 0.9044 GB Notification: Performance of NFInst.instExpressions: time 0.001617/0.003382, allocations: 1.64 MB / 1.157 GB, free: 23.67 MB / 0.9044 GB Notification: Performance of NFInst.updateImplicitVariability: time 9.469e-05/0.003477, allocations: 7.094 kB / 1.157 GB, free: 23.66 MB / 0.9044 GB Notification: Performance of NFTyping.typeComponents: time 5.218e-05/0.003529, allocations: 28.45 kB / 1.157 GB, free: 23.64 MB / 0.9044 GB Notification: Performance of NFTyping.typeBindings: time 0.0001241/0.003653, allocations: 60 kB / 1.157 GB, free: 23.59 MB / 0.9044 GB Notification: Performance of NFTyping.typeClassSections: time 0.0007671/0.00442, allocations: 450 kB / 1.158 GB, free: 23.36 MB / 0.9044 GB Notification: Performance of NFFlatten.flatten: time 0.0005951/0.005015, allocations: 0.7805 MB / 1.158 GB, free: 23.02 MB / 0.9044 GB Notification: Performance of NFFlatten.resolveConnections: time 0.0001493/0.005164, allocations: 64.91 kB / 1.158 GB, free: 22.98 MB / 0.9044 GB Notification: Performance of NFEvalConstants.evaluate: time 0.0002802/0.005445, allocations: 311.8 kB / 1.159 GB, free: 22.86 MB / 0.9044 GB Notification: Performance of NFSimplifyModel.simplify: time 0.0002952/0.00574, allocations: 286.8 kB / 1.159 GB, free: 22.75 MB / 0.9044 GB Notification: Performance of NFPackage.collectConstants: time 0.0001247/0.005864, allocations: 75.28 kB / 1.159 GB, free: 22.75 MB / 0.9044 GB Notification: Performance of NFFlatten.collectFunctions: time 0.0001537/0.006018, allocations: 87.5 kB / 1.159 GB, free: 22.75 MB / 0.9044 GB Notification: Performance of combineBinaries: time 0.0005477/0.006566, allocations: 0.9244 MB / 1.16 GB, free: 22.16 MB / 0.9044 GB Notification: Performance of replaceArrayConstructors: time 0.0001708/0.006737, allocations: 401.8 kB / 1.16 GB, free: 21.89 MB / 0.9044 GB Notification: Performance of NFVerifyModel.verify: time 9.976e-05/0.006836, allocations: 52.5 kB / 1.161 GB, free: 21.89 MB / 0.9044 GB Notification: Performance of FrontEnd: time 2.723e-05/0.006864, allocations: 15.06 kB / 1.161 GB, free: 21.89 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: 54 (54) * Number of variables: 54 (54) Notification: Performance of [SIM] Bindings: time 0.001833/0.008696, allocations: 2.425 MB / 1.163 GB, free: 20.45 MB / 0.9044 GB Notification: Performance of [SIM] FunctionAlias: time 0.0002344/0.008931, allocations: 290.1 kB / 1.163 GB, free: 20.31 MB / 0.9044 GB Notification: Performance of [SIM] Early Inline: time 0.002256/0.01119, allocations: 2.758 MB / 1.166 GB, free: 19.02 MB / 0.9044 GB Notification: Performance of [SIM] Simplify 1: time 0.0005431/0.01173, allocations: 470.1 kB / 1.166 GB, free: 18.84 MB / 0.9044 GB Notification: Performance of [SIM] Alias: time 0.001912/0.01364, allocations: 1.92 MB / 1.168 GB, free: 17.88 MB / 0.9044 GB Notification: Performance of [SIM] Simplify 2: time 0.0005186/0.01416, allocations: 480.2 kB / 1.169 GB, free: 17.7 MB / 0.9044 GB Notification: Performance of [SIM] Remove Stream: time 0.0003973/0.01456, allocations: 430.7 kB / 1.169 GB, free: 17.49 MB / 0.9044 GB Notification: Performance of [SIM] Detect States: time 0.001002/0.01556, allocations: 1.092 MB / 1.17 GB, free: 16.89 MB / 0.9044 GB Notification: Performance of [SIM] Events: time 0.0003696/0.01593, allocations: 320.1 kB / 1.17 GB, free: 16.71 MB / 0.9044 GB Notification: Performance of [SIM] Partitioning: time 0.0009645/0.01689, allocations: 0.9959 MB / 1.171 GB, free: 16.34 MB / 0.9044 GB Notification: Performance of [SIM] Causalize: time 0.001485/0.01838, allocations: 1.236 MB / 1.173 GB, free: 16.07 MB / 0.9044 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.001952/0.02033, allocations: 2.393 MB / 1.175 GB, free: 14.97 MB / 0.9044 GB Notification: Performance of [INI] Simplify: time 0.001339/0.02167, allocations: 1.106 MB / 1.176 GB, free: 14.38 MB / 0.9044 GB Notification: Performance of [INI] Inline: time 0.002699/0.02437, allocations: 3.346 MB / 1.179 GB, free: 12.75 MB / 0.9044 GB Notification: Performance of [INI] Partitioning: time 9.034e-05/0.02446, allocations: 60.73 kB / 1.179 GB, free: 12.71 MB / 0.9044 GB Notification: Performance of [INI] Cleanup: time 0.0005252/0.02498, allocations: 0.6366 MB / 1.18 GB, free: 12.45 MB / 0.9044 GB Notification: Performance of [INI] Causalize: time 0.003627/0.02861, allocations: 2.971 MB / 1.183 GB, free: 11.68 MB / 0.9044 GB Notification: Performance of [INI] Tearing: time 3.767e-05/0.02865, allocations: 80.03 kB / 1.183 GB, free: 11.62 MB / 0.9044 GB Notification: Performance of [SIM] Initialization: time 1.112e-06/0.02865, allocations: 1.188 kB / 1.183 GB, free: 11.62 MB / 0.9044 GB Notification: Performance of [SIM] DAE-Mode: time 6.113e-05/0.02871, allocations: 62.31 kB / 1.183 GB, free: 11.56 MB / 0.9044 GB Notification: Performance of [SIM] Remove Dummies: time 6.843e-06/0.02872, allocations: 4.812 kB / 1.183 GB, free: 11.56 MB / 0.9044 GB Notification: Performance of [SIM] Tearing: time 1.722e-05/0.02874, allocations: 44.62 kB / 1.183 GB, free: 11.53 MB / 0.9044 GB Notification: Performance of [SIM] Categorize: time 1.685e-05/0.02875, allocations: 3.438 kB / 1.183 GB, free: 11.53 MB / 0.9044 GB Notification: Performance of [SIM] Solve: time 0.0006431/0.0294, allocations: 471.2 kB / 1.184 GB, free: 11.35 MB / 0.9044 GB Notification: Performance of [SIM] Jacobian: time 1.009e-05/0.02941, allocations: 5.094 kB / 1.184 GB, free: 11.35 MB / 0.9044 GB Notification: Partition statistics after passing the back-end: * Number of ODE partitions: ..................... 0 * Number of algebraic partitions: ............... 0 * Number of ODE event partitions: ............... 0 * Number of algebraic event partitions: ......... 2 * Number of clocked partitions: ................. 0 * Number of initial partitions: ................. 1 * Number of initial(lambda=0) partitions: ....... 0 Notification: Variable statistics after passing the back-end: * Number of states: ............................. 0 (0) {} * Number of discrete states: .................... 34 (34) {booPul1.y, booPul.y, onDelay77.y, onDelay77.t_next, onDelay33.y, onDelay33.t_next, onDelay66.y, onDelay66.t_next, onDelay55.y, onDelay55.t_next, onDelay44.y, onDelay44.t_next, onDelay22.y, onDelay22.t_next, onDelay11.y, onDelay11.t_next, onDelay00.y, onDelay00.t_next, onDelay7.y, onDelay7.t_next, onDelay3.y, onDelay3.t_next, onDelay6.y, onDelay6.t_next, onDelay5.y, onDelay5.t_next, onDelay4.y, onDelay4.t_next, onDelay2.y, onDelay2.t_next, onDelay1.y, onDelay1.t_next, onDelay0.y, onDelay0.t_next} * Number of clocked states: ..................... 0 (0) {} * Number of discrete variables: ................. 56 (56) {onDelay0.u, onDelay1.u, onDelay2.u, onDelay4.u, onDelay5.u, onDelay6.u, not1.u, onDelay3.u, onDelay7.u, onDelay00.u, onDelay11.u, onDelay22.u, onDelay44.u, onDelay55.u, onDelay66.u, not2.u, onDelay33.u, onDelay77.u, $SEV_33, $SEV_32, $SEV_31, $SEV_30, $SEV_29, $SEV_28, $SEV_27, $SEV_26, $SEV_25, $SEV_24, $SEV_23, $SEV_22, $SEV_21, $SEV_20, $SEV_19, $SEV_18, $SEV_17, $SEV_16, $SEV_15, $SEV_14, $SEV_13, $SEV_12, $SEV_11, $SEV_10, $SEV_9, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_3, $TEV_2, $TEV_1, $TEV_0} * Number of clocks: ............................. 0 (0) {} * Number of top-level inputs: ................... 0 (0) {} Notification: [Simulation] Strong Component statistics after passing the back-end: * Number of single strong components: ........... 56 (scalar:56, array:0, record:0) * Number of multi strong components: ............ 34 (algorithm:0, when:34, if:0, tuple:0) * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0) * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0) Notification: [Initialization] Strong Component statistics after passing the back-end: * Number of single strong components: ........... 122 (scalar:122, array:0, record:0) * Number of multi strong components: ............ 34 (algorithm:34, when:0, if:0, tuple:0) * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0) * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0) Notification: Performance of backend: time 0.0001207/0.02953, allocations: 92.77 kB / 1.184 GB, free: 11.27 MB / 0.9044 GB Notification: Performance of SimCode: time 0.00142/0.03095, allocations: 1.202 MB / 1.185 GB, free: 10.65 MB / 0.9044 GB Notification: Performance of Templates: time 0.01017/0.04112, allocations: 5.613 MB / 1.19 GB, free: 10.05 MB / 0.9044 GB " [Timeout remaining time 300] make -j1 -f Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay.makefile [Timeout 300] (rm -f Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay.pipe ; mkfifo Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay.pipe ; head -c 1048576 < Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay.pipe >> ../files/Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay.sim & ./Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay -abortSlowSimulation -alarm=400 -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay.pipe 2>&1) [Timeout 400] diffSimulationResults("Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_Controls_OBC_CDL_Logical_Validation_TrueDelay.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_Buildings.Controls.OBC.CDL.Logical.Validation.TrueDelay.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300] "" [Timeout remaining time 300] "" Variables in the reference:time,onDelay0.u,onDelay0.y,onDelay1.y,onDelay2.y,onDelay3.y,onDelay4.y,onDelay5.y,onDelay6.y,onDelay7.y,onDelay00.u,onDelay00.y,onDelay11.y,onDelay22.y,onDelay33.y,onDelay44.y,onDelay55.y,onDelay66.y,onDelay77.y Variables in the result:booPul.period,booPul.shift,booPul.t0,booPul.t1,booPul.width,booPul1.period,booPul1.shift,booPul1.t0,booPul1.t1,booPul1.width,onDelay0.delayOnInit,onDelay0.delayTime,onDelay0.t_past,onDelay0.u,onDelay0.y,onDelay00.delayOnInit,onDelay00.delayTime,onDelay00.t_past,onDelay00.u,onDelay00.y,onDelay1.delayOnInit,onDelay1.delayTime,onDelay1.t_past,onDelay1.y,onDelay11.delayOnInit,onDelay11.delayTime,onDelay11.t_past,onDelay11.y,onDelay2.delayOnInit,onDelay2.delayTime,onDelay2.t_past,onDelay2.y,onDelay22.delayOnInit,onDelay22.delayTime,onDelay22.t_past,onDelay22.y,onDelay3.delayOnInit,onDelay3.delayTime,onDelay3.t_past,onDelay3.y,onDelay33.delayOnInit,onDelay33.delayTime,onDelay33.t_past,onDelay33.y,onDelay4.delayOnInit,onDelay4.delayTime,onDelay4.t_past,onDelay4.y,onDelay44.delayOnInit,onDelay44.delayTime,onDelay44.t_past,onDelay44.y,onDelay5.delayOnInit,onDelay5.delayTime,onDelay5.t_past,onDelay5.y,onDelay55.delayOnInit,onDelay55.delayTime,onDelay55.t_past,onDelay55.y,onDelay6.delayOnInit,onDelay6.delayTime,onDelay6.t_past,onDelay6.y,onDelay66.delayOnInit,onDelay66.delayTime,onDelay66.t_past,onDelay66.y,onDelay7.delayOnInit,onDelay7.delayTime,onDelay7.t_past,onDelay7.y,onDelay77.delayOnInit,onDelay77.delayTime,onDelay77.t_past,onDelay77.y,time [Calling sys.exit(0), Time elapsed: 7.786804913019296]