Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction.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.0019/0.0019, allocations: 107.6 kB / 21.2 MB, free: 0.6641 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.002432/0.002432, allocations: 209.2 kB / 24.49 MB, free: 3.965 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.592/1.592, allocations: 230.6 MB / 258.3 MB, free: 7.785 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0+maint.om/package.mo): time 0.3041/0.3041, allocations: 46.96 MB / 361.6 MB, free: 4.027 MB / 286.1 MB
"
[Timeout remaining time 179]
Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0+maint.om/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(ModelicaTest.Blocks.UnitDeduction,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5004,variableFilter="time|Asec.y|PI.x|PID.D.x|PID.I.y|PID1.D.x|PID1.I.y|Vsec.y|Wsec.y|derivative.x|firstOrder.y|inertia.phi|inertia.w|integrator.y|limIntegrator.y|secondOrder.y|secondOrder.yd",fileNamePrefix="ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction")
translateModel(ModelicaTest.Blocks.UnitDeduction,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5004,variableFilter="time|Asec.y|PI.x|PID.D.x|PID.I.y|PID1.D.x|PID1.I.y|Vsec.y|Wsec.y|derivative.x|firstOrder.y|inertia.phi|inertia.w|integrator.y|limIntegrator.y|secondOrder.y|secondOrder.yd",fileNamePrefix="ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 3.884e-05/3.884e-05, allocations: 6.219 kB / 0.4973 GB, free: 7.254 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Blocks.UnitDeduction): time 0.007049/0.007088, allocations: 3.698 MB / 0.5009 GB, free: 3.535 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.002945/0.01003, allocations: 1.227 MB / 0.5021 GB, free: 2.305 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0004307/0.01046, allocations: 31.75 kB / 0.5021 GB, free: 2.273 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0003677/0.01083, allocations: 122.7 kB / 0.5022 GB, free: 2.152 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0005998/0.01143, allocations: 174.5 kB / 0.5024 GB, free: 1.98 MB / 366.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0009343/0.01237, allocations: 402.2 kB / 0.5028 GB, free: 1.59 MB / 366.1 MB
Notification: Performance of NFFlatten.flatten: time 0.001286/0.01365, allocations: 1.112 MB / 0.5039 GB, free: 488 kB / 366.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0004568/0.01411, allocations: 210.2 kB / 0.5041 GB, free: 260 kB / 366.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0006823/0.01479, allocations: 434.4 kB / 0.5045 GB, free: 15.83 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003706/0.01516, allocations: 326.2 kB / 0.5048 GB, free: 15.51 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001027/0.01526, allocations: 64 kB / 0.5049 GB, free: 15.45 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.000182/0.01545, allocations: 68 kB / 0.5049 GB, free: 15.38 MB / 382.1 MB
Notification: Performance of combineBinaries: time 0.001146/0.01659, allocations: 1.445 MB / 0.5063 GB, free: 13.92 MB / 382.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0006979/0.01729, allocations: 0.9788 MB / 0.5073 GB, free: 12.93 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 9.172e-05/0.01738, allocations: 52 kB / 0.5073 GB, free: 12.88 MB / 382.1 MB
Notification: Performance of FrontEnd: time 0.0001865/0.01757, allocations: 67.52 kB / 0.5074 GB, free: 12.81 MB / 382.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 132 (132)
 * Number of variables: 132 (132)
Notification: Performance of [SIM] Bindings: time 0.003296/0.02086, allocations: 3.242 MB / 0.5106 GB, free: 9.375 MB / 382.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0004192/0.02128, allocations: 339.7 kB / 0.5109 GB, free: 9.031 MB / 382.1 MB
Notification: Performance of [SIM] Early Inline: time 0.001739/0.02302, allocations: 1.628 MB / 0.5125 GB, free: 7.367 MB / 382.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0005723/0.02359, allocations: 364.7 kB / 0.5128 GB, free: 6.938 MB / 382.1 MB
Notification: Performance of [SIM] Alias: time 0.004296/0.02789, allocations: 2.83 MB / 0.5156 GB, free: 3.699 MB / 382.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0004018/0.02829, allocations: 246.1 kB / 0.5158 GB, free: 3.41 MB / 382.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0001632/0.02846, allocations: 128.3 kB / 0.516 GB, free: 3.258 MB / 382.1 MB
Notification: Performance of [SIM] Detect States: time 0.0005256/0.02898, allocations: 377 kB / 0.5163 GB, free: 2.836 MB / 382.1 MB
Notification: Performance of [SIM] Events: time 0.000214/0.02919, allocations: 105.5 kB / 0.5164 GB, free: 2.73 MB / 382.1 MB
Notification: Performance of [SIM] Partitioning: time 0.0005862/0.02978, allocations: 465.6 kB / 0.5169 GB, free: 2.238 MB / 382.1 MB
Notification: Performance of [SIM] Causalize: time 0.001158/0.03094, allocations: 0.8011 MB / 0.5176 GB, free: 1.402 MB / 382.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0009122/0.03185, allocations: 0.8391 MB / 0.5185 GB, free: 0.5625 MB / 382.1 MB
Notification: Performance of [INI] Simplify: time 0.2628/0.2946, allocations: 0.7083 MB / 0.5191 GB, free: 26.88 MB / 382.1 MB
Notification: Performance of [INI] Inline: time 0.001753/0.2964, allocations: 1.478 MB / 0.5206 GB, free: 26.88 MB / 382.1 MB
Notification: Performance of [INI] Partitioning: time 7.123e-05/0.2964, allocations: 37.03 kB / 0.5206 GB, free: 26.85 MB / 382.1 MB
Notification: Performance of [INI] Cleanup: time 0.0003413/0.2968, allocations: 345.3 kB / 0.521 GB, free: 26.84 MB / 382.1 MB
Notification: Performance of [INI] Causalize: time 0.004589/0.3014, allocations: 2.866 MB / 0.5238 GB, free: 26.63 MB / 382.1 MB
Notification: Performance of [INI] Tearing: time 6.305e-05/0.3014, allocations: 95.41 kB / 0.5238 GB, free: 26.59 MB / 382.1 MB
Notification: Performance of [SIM] Initialization: time 1.563e-06/0.3014, allocations: 1.938 kB / 0.5238 GB, free: 26.59 MB / 382.1 MB
Notification: Performance of [SIM] Remove Dummies: time 1.234e-05/0.3014, allocations: 1.406 kB / 0.5238 GB, free: 26.59 MB / 382.1 MB
Notification: Performance of [SIM] Tearing: time 1.334e-05/0.3015, allocations: 27.59 kB / 0.5239 GB, free: 26.57 MB / 382.1 MB
Notification: Performance of [SIM] Categorize: time 2.013e-05/0.3015, allocations: 4.953 kB / 0.5239 GB, free: 26.57 MB / 382.1 MB
Notification: Performance of [SIM] Solve: time 0.001197/0.3027, allocations: 0.6774 MB / 0.5245 GB, free: 26.55 MB / 382.1 MB
Notification: Performance of [SIM] Jacobian: time 0.0006405/0.3033, allocations: 0.6237 MB / 0.5252 GB, free: 26.13 MB / 382.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 2
 * Number of algebraic event partitions: ......... 3
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 1
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 16 (16) {integrator.y, inertia.w, inertia.phi, limIntegrator.y, derivative.x, firstOrder.y, secondOrder.y, secondOrder.yd, PI.x, PID.I.y, PID.D.x, PID1.I.y, PID1.D.x, Wsec.y, Vsec.y, Asec.y}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 7 (7) {$SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $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: ........... 54 (scalar:54, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 94 (scalar:94, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 94 (scalar:94, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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.0001951/0.3035, allocations: 55.92 kB / 0.5252 GB, free: 26.09 MB / 382.1 MB
Notification: Performance of SimCode: time 0.003081/0.3066, allocations: 2.233 MB / 0.5274 GB, free: 25.28 MB / 382.1 MB
Notification: Performance of Templates: time 0.01084/0.3174, allocations: 4.55 MB / 0.5318 GB, free: 24.88 MB / 382.1 MB
"
[Timeout remaining time 660]
make -j1 -f ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction.makefile [Timeout 660]
(rm -f ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction.pipe ; mkfifo ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction.pipe ; head -c 1048576 < ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction.pipe >> ../files/ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction.sim & ./ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction.pipe 2>&1) [Timeout 480]
diffSimulationResults("ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/ModelicaTest/Blocks/UnitDeduction/UnitDeduction.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_4.1.0_ModelicaTest.Blocks.UnitDeduction.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 660]
Reference file matches
[Calling sys.exit(0), Time elapsed: 5.733873079996556]