Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0_Modelica.Electrical.Machines.Examples.ControlledDCDrives.PositionControlledDCPM.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.001609/0.001609, 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.002107/0.002107, allocations: 210.2 kB / 24.49 MB, free: 3.961 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.553/1.553, allocations: 230.6 MB / 258.3 MB, free: 7.809 MB / 206.1 MB
"
[Timeout remaining time 178]
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(Modelica.Electrical.Machines.Examples.ControlledDCDrives.PositionControlledDCPM,tolerance=1e-06,outputFormat="mat",numberOfIntervals=25000,variableFilter="time|loadInertia.phi|loadInertia.w|dcpm.la.i|armatureInverter.vDCFilter.y|armatureInverter.iMotFilter.y|armatureInverter.idealDcDc.deadTime.y|armatureInverter.idealDcDc.powerController.y|armatureInverter.vMotFilter.y|armatureInverter.iDCFilter.y|currentController.integrator.y|speedController.integrator.y",fileNamePrefix="Modelica_4.1.0_Modelica.Electrical.Machines.Examples.ControlledDCDrives.PositionControlledDCPM")
translateModel(Modelica.Electrical.Machines.Examples.ControlledDCDrives.PositionControlledDCPM,tolerance=1e-06,outputFormat="mat",numberOfIntervals=25000,variableFilter="time|loadInertia.phi|loadInertia.w|dcpm.la.i|armatureInverter.vDCFilter.y|armatureInverter.iMotFilter.y|armatureInverter.idealDcDc.deadTime.y|armatureInverter.idealDcDc.powerController.y|armatureInverter.vMotFilter.y|armatureInverter.iDCFilter.y|currentController.integrator.y|speedController.integrator.y",fileNamePrefix="Modelica_4.1.0_Modelica.Electrical.Machines.Examples.ControlledDCDrives.PositionControlledDCPM") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.568e-05/2.568e-05, allocations: 6.219 kB / 379 MB, free: 2.504 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Electrical.Machines.Examples.ControlledDCDrives.PositionControlledDCPM): time 0.1994/0.1994, allocations: 13.25 MB / 392.2 MB, free: 7.395 MB / 302.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01301/0.2125, allocations: 5.477 MB / 397.7 MB, free: 3.43 MB / 302.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004509/0.217, allocations: 86.31 kB / 397.8 MB, free: 3.395 MB / 302.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.004014/0.221, allocations: 0.9152 MB / 398.7 MB, free: 2.949 MB / 302.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.00389/0.2249, allocations: 0.6507 MB / 399.3 MB, free: 2.469 MB / 302.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002687/0.2276, allocations: 0.7435 MB / 400.1 MB, free: 2 MB / 302.1 MB
Notification: Performance of NFFlatten.flatten: time 0.005447/0.233, allocations: 3.311 MB / 403.4 MB, free: 312 kB / 302.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002356/0.2354, allocations: 0.7684 MB / 404.1 MB, free: 15.8 MB / 318.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002769/0.2381, allocations: 1.167 MB / 405.3 MB, free: 15.15 MB / 318.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002394/0.2405, allocations: 1.101 MB / 406.4 MB, free: 14.3 MB / 318.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0005116/0.241, allocations: 255.9 kB / 406.7 MB, free: 14.3 MB / 318.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002167/0.2432, allocations: 0.6894 MB / 407.4 MB, free: 14.12 MB / 318.1 MB
Notification: Performance of combineBinaries: time 0.004644/0.2478, allocations: 4.637 MB / 412 MB, free: 10.55 MB / 318.1 MB
Notification: Performance of replaceArrayConstructors: time 0.002956/0.2508, allocations: 2.857 MB / 414.9 MB, free: 8.508 MB / 318.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0006711/0.2515, allocations: 177.8 kB / 415 MB, free: 8.508 MB / 318.1 MB
Notification: Performance of FrontEnd: time 0.0007371/0.2522, allocations: 101.5 kB / 415.1 MB, free: 8.457 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: 469 (469)
 * Number of variables: 469 (469)
Notification: Performance of [SIM] Bindings: time 0.01476/0.267, allocations: 12.31 MB / 427.4 MB, free: 12.35 MB / 334.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.001795/0.2688, allocations: 1.179 MB / 428.6 MB, free: 11.15 MB / 334.1 MB
Notification: Performance of [SIM] Early Inline: time 0.006579/0.2754, allocations: 6.131 MB / 434.7 MB, free: 4.961 MB / 334.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.002235/0.2776, allocations: 1.178 MB / 435.9 MB, free: 3.699 MB / 334.1 MB
Notification: Performance of [SIM] Alias: time 0.01733/0.2949, allocations: 10.05 MB / 446 MB, free: 8.555 MB / 350.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.001042/0.296, allocations: 0.5883 MB / 446.6 MB, free: 7.906 MB / 350.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0003917/0.2964, allocations: 308.1 kB / 446.9 MB, free: 7.566 MB / 350.1 MB
Notification: Performance of [SIM] Detect States: time 0.0009841/0.2973, allocations: 0.796 MB / 447.7 MB, free: 6.715 MB / 350.1 MB
Notification: Performance of [SIM] Events: time 0.0005282/0.2979, allocations: 317.4 kB / 448 MB, free: 6.402 MB / 350.1 MB
Notification: Performance of [SIM] Partitioning: time 0.001555/0.2994, allocations: 1.245 MB / 449.2 MB, free: 5.102 MB / 350.1 MB
Error: Internal error NBVariable.makeDummyState failed for $DER.armatureInverter.idealDcDc.powerController.y.
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 2.9458194142207503]
Failed to read output from testmodel.py, exit status != 0:
['time', 'loadInertia.phi', 'loadInertia.w', 'dcpm.la.i', 'armatureInverter.vDCFilter.y', 'armatureInverter.iMotFilter.y', 'armatureInverter.idealDcDc.deadTime.y', 'armatureInverter.idealDcDc.powerController.y', 'armatureInverter.vMotFilter.y', 'armatureInverter.iDCFilter.y', 'currentController.integrator.y', 'speedController.integrator.y']
0.31508915964514017 0.32930474800000004 0.073889781
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fc58320af20>