Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildingSystems_BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez.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.001757/0.001757, allocations: 79.2 kB / 19.18 MB, free: 2.516 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.002177/0.002177, allocations: 163.4 kB / 22.46 MB, free: 5.375 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.469/1.469, allocations: 177.2 MB / 202.8 MB, free: 9.176 MB / 190.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 master/package.mo): time 0.002469/0.002469, allocations: 241.2 kB / 259.4 MB, free: 472 kB / 238.1 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo): time 1.085/1.085, allocations: 138.4 MB / 454.3 MB, free: 1.996 MB / 366.1 MB " [Timeout remaining time 179] Using package BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo) Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 master/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(BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez") translateModel(BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez") [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 3.928e-06/3.928e-06, allocations: 4 kB / 0.6467 GB, free: 5.043 MB / 0.5606 GB Notification: Performance of FrontEnd - Absyn->SCode: time 2.437e-05/2.829e-05, allocations: 10.16 kB / 0.6468 GB, free: 5.031 MB / 0.5606 GB Notification: Performance of NFInst.instantiate(BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez): time 0.2471/0.2472, allocations: 7.362 MB / 0.6539 GB, free: 53.14 MB / 0.5606 GB Notification: Performance of NFInst.instExpressions: time 0.1461/0.3933, allocations: 133.9 MB / 0.7848 GB, free: 3.02 MB / 0.6075 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001239/0.3945, allocations: 27.81 kB / 0.7848 GB, free: 2.992 MB / 0.6075 GB Notification: Performance of NFTyping.typeComponents: time 0.001051/0.3956, allocations: 340.5 kB / 0.7851 GB, free: 2.656 MB / 0.6075 GB Notification: Performance of NFTyping.typeBindings: time 0.002815/0.3984, allocations: 0.9032 MB / 0.786 GB, free: 1.75 MB / 0.6075 GB Notification: Performance of NFTyping.typeClassSections: time 0.002973/0.4014, allocations: 1.406 MB / 0.7874 GB, free: 360 kB / 0.6075 GB Notification: Performance of NFFlatten.flatten: time 0.003494/0.4049, allocations: 3.09 MB / 0.7904 GB, free: 13.25 MB / 0.6231 GB Notification: Performance of NFFlatten.resolveConnections: time 0.001621/0.4065, allocations: 0.9721 MB / 0.7913 GB, free: 12.22 MB / 0.6231 GB Notification: Performance of NFEvalConstants.evaluate: time 0.002432/0.4089, allocations: 1.829 MB / 0.7931 GB, free: 10.39 MB / 0.6231 GB Notification: Performance of NFSimplifyModel.simplify: time 0.001627/0.4106, allocations: 1.044 MB / 0.7941 GB, free: 9.34 MB / 0.6231 GB Notification: Performance of NFPackage.collectConstants: time 0.0005002/0.4111, allocations: 335.9 kB / 0.7944 GB, free: 9.012 MB / 0.6231 GB Notification: Performance of NFFlatten.collectFunctions: time 0.001371/0.4124, allocations: 0.7103 MB / 0.7951 GB, free: 8.301 MB / 0.6231 GB Notification: Performance of NFScalarize.scalarize: time 0.0007315/0.4132, allocations: 0.7125 MB / 0.7958 GB, free: 7.586 MB / 0.6231 GB Notification: Performance of NFVerifyModel.verify: time 0.001124/0.4143, allocations: 0.9348 MB / 0.7968 GB, free: 6.652 MB / 0.6231 GB Notification: Performance of NFConvertDAE.convert: time 0.004521/0.4188, allocations: 3.957 MB / 0.8006 GB, free: 2.684 MB / 0.6231 GB Notification: Performance of FrontEnd - DAE generated: time 3.987e-06/0.4188, allocations: 0 / 0.8006 GB, free: 2.684 MB / 0.6231 GB Notification: Performance of FrontEnd: time 1.263e-06/0.4188, allocations: 0 / 0.8006 GB, free: 2.684 MB / 0.6231 GB Notification: Performance of Transformations before backend: time 3.539e-05/0.4188, allocations: 0 / 0.8006 GB, free: 2.684 MB / 0.6231 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 578 * Number of variables: 578 Notification: Performance of Generate backend data structure: time 0.006411/0.4253, allocations: 2.814 MB / 0.8034 GB, free: 15.8 MB / 0.6387 GB Notification: Performance of prepare preOptimizeDAE: time 3.602e-05/0.4253, allocations: 10.06 kB / 0.8034 GB, free: 15.79 MB / 0.6387 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01992/0.4452, allocations: 2.32 MB / 0.8056 GB, free: 13.47 MB / 0.6387 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.002756/0.448, allocations: 1.226 MB / 0.8068 GB, free: 12.21 MB / 0.6387 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001806/0.4481, allocations: 172.7 kB / 0.807 GB, free: 12.04 MB / 0.6387 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004234/0.4486, allocations: 216 kB / 0.8072 GB, free: 11.83 MB / 0.6387 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.009654/0.4582, allocations: 3.54 MB / 0.8107 GB, free: 8.141 MB / 0.6387 GB Notification: Performance of preOpt findStateOrder (simulation): time 3.949e-05/0.4583, allocations: 0 / 0.8107 GB, free: 8.141 MB / 0.6387 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003167/0.4586, allocations: 99.98 kB / 0.8108 GB, free: 8.043 MB / 0.6387 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.438e-05/0.4586, allocations: 52 kB / 0.8108 GB, free: 7.992 MB / 0.6387 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01419/0.4728, allocations: 4.143 MB / 0.8149 GB, free: 3.832 MB / 0.6387 GB Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts. Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.01572/0.4886, allocations: 6.121 MB / 0.8208 GB, free: 13.66 MB / 0.6544 GB Notification: Performance of preOpt comSubExp (simulation): time 0.01016/0.4987, allocations: 2.713 MB / 0.8235 GB, free: 10.94 MB / 0.6544 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.004903/0.5036, allocations: 1.356 MB / 0.8248 GB, free: 9.582 MB / 0.6544 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0006253/0.5042, allocations: 118.1 kB / 0.8249 GB, free: 9.465 MB / 0.6544 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.005802/0.51, allocations: 1.941 MB / 0.8268 GB, free: 7.48 MB / 0.6544 GB Notification: Performance of pre-optimization done (n=213): time 4.689e-06/0.51, allocations: 4 kB / 0.8268 GB, free: 7.477 MB / 0.6544 GB Notification: Performance of matching and sorting (n=213): time 0.01703/0.5271, allocations: 4.387 MB / 0.8311 GB, free: 3.082 MB / 0.6544 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001567/0.5272, allocations: 209.9 kB / 0.8313 GB, free: 2.836 MB / 0.6544 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001262/0.5285, allocations: 0.8219 MB / 0.8321 GB, free: 2.004 MB / 0.6544 GB Notification: Performance of collectPreVariables (initialization): time 0.0002319/0.5287, allocations: 61.7 kB / 0.8322 GB, free: 1.938 MB / 0.6544 GB Notification: Performance of collectInitialEqns (initialization): time 0.0007448/0.5295, allocations: 0.7719 MB / 0.8329 GB, free: 1.156 MB / 0.6544 GB Notification: Performance of collectInitialBindings (initialization): time 0.000738/0.5302, allocations: 0.7087 MB / 0.8336 GB, free: 452 kB / 0.6544 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0008558/0.5311, allocations: 387.3 kB / 0.834 GB, free: 60 kB / 0.6544 GB Notification: Performance of setup shared object (initialization): time 0.0001792/0.5312, allocations: 313.1 kB / 0.8343 GB, free: 15.75 MB / 0.67 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.004815/0.5361, allocations: 1.249 MB / 0.8355 GB, free: 14.5 MB / 0.67 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.005134/0.5412, allocations: 1.567 MB / 0.837 GB, free: 12.88 MB / 0.67 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.009851/0.551, allocations: 2.614 MB / 0.8396 GB, free: 10.25 MB / 0.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.813e-06/0.551, allocations: 4 kB / 0.8396 GB, free: 10.24 MB / 0.67 GB Notification: Performance of matching and sorting (n=241) (initialization): time 0.01163/0.5627, allocations: 3.117 MB / 0.8426 GB, free: 7.113 MB / 0.67 GB Notification: Performance of prepare postOptimizeDAE: time 2.229e-05/0.5627, allocations: 4 kB / 0.8426 GB, free: 7.109 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.289e-05/0.5627, allocations: 4.547 kB / 0.8426 GB, free: 7.105 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0006643/0.5634, allocations: 88.78 kB / 0.8427 GB, free: 7.016 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004091/0.5675, allocations: 0.6045 MB / 0.8433 GB, free: 6.41 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002327/0.5698, allocations: 1.494 MB / 0.8448 GB, free: 4.812 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00331/0.5731, allocations: 359.4 kB / 0.8451 GB, free: 4.465 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002829/0.5734, allocations: 103.9 kB / 0.8452 GB, free: 4.363 MB / 0.67 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 7 * Number of states: 0 () * Number of discrete variables: 26 (weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,HDifWal.incAng.decAng.tNext,$PRE.HDifWal.incAng.decAng.tNext,HDifFlo.incAng.decAng.tNext,$PRE.HDifFlo.incAng.decAng.tNext,HDifRoo.incAng.decAng.tNext,$PRE.HDifRoo.incAng.decAng.tNext,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (239): * Single equations (assignments): 238 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(1,2)} Notification: Performance of prepare postOptimizeDAE: time 0.001108/0.5745, allocations: 447.3 kB / 0.8456 GB, free: 3.918 MB / 0.67 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004403/0.5749, allocations: 159 kB / 0.8458 GB, free: 3.762 MB / 0.67 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01291/0.5878, allocations: 3.701 MB / 0.8494 GB, free: 52 kB / 0.67 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.836e-05/0.5879, allocations: 20 kB / 0.8494 GB, free: 32 kB / 0.67 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 4.779e-06/0.5879, allocations: 4 kB / 0.8494 GB, free: 28 kB / 0.67 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.06e-05/0.5879, allocations: 15.89 kB / 0.8494 GB, free: 12 kB / 0.67 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00302/0.5909, allocations: 1.744 MB / 0.8511 GB, free: 14.24 MB / 0.6856 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.003e-06/0.5909, allocations: 0 / 0.8511 GB, free: 14.24 MB / 0.6856 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003815/0.5948, allocations: 0.5578 MB / 0.8517 GB, free: 13.68 MB / 0.6856 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0004968/0.5953, allocations: 76.78 kB / 0.8518 GB, free: 13.6 MB / 0.6856 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002362/0.5955, allocations: 77.84 kB / 0.8518 GB, free: 13.53 MB / 0.6856 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002113/0.5976, allocations: 1.536 MB / 0.8533 GB, free: 11.89 MB / 0.6856 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.336e-06/0.5976, allocations: 4 kB / 0.8533 GB, free: 11.88 MB / 0.6856 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01138/0.609, allocations: 3.203 MB / 0.8565 GB, free: 8.652 MB / 0.6856 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001084/0.6101, allocations: 472.1 kB / 0.8569 GB, free: 8.188 MB / 0.6856 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003546/0.6104, allocations: 55.88 kB / 0.857 GB, free: 8.133 MB / 0.6856 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003069/0.6135, allocations: 267.7 kB / 0.8572 GB, free: 7.871 MB / 0.6856 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003549/0.6138, allocations: 161.7 kB / 0.8574 GB, free: 7.715 MB / 0.6856 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002699/0.6141, allocations: 91.91 kB / 0.8575 GB, free: 7.625 MB / 0.6856 GB Notification: Performance of sorting global known variables: time 0.0009335/0.6151, allocations: 0.6102 MB / 0.8581 GB, free: 7.004 MB / 0.6856 GB Notification: Performance of sort global known variables: time 8.1e-08/0.6151, allocations: 0 / 0.8581 GB, free: 7.004 MB / 0.6856 GB Notification: Performance of remove unused functions: time 0.001821/0.6169, allocations: 0.6974 MB / 0.8587 GB, free: 6.305 MB / 0.6856 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 1 * Number of states: 0 () * Number of discrete variables: 16 ($whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,HDifRoo.incAng.decAng.tNext,HDifFlo.incAng.decAng.tNext,HDifWal.incAng.decAng.tNext) * Number of discrete states: 8 (weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,HDifRoo.incAng.decAng.tNext,HDifFlo.incAng.decAng.tNext,HDifWal.incAng.decAng.tNext) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (231): * Single equations (assignments): 222 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 8 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(1,3)} Notification: Performance of Backend phase and start with SimCode phase: time 0.002388/0.6193, allocations: 0.7118 MB / 0.8594 GB, free: 5.82 MB / 0.6856 GB Notification: Performance of simCode: created initialization part: time 0.0108/0.6301, allocations: 3.034 MB / 0.8624 GB, free: 2.773 MB / 0.6856 GB Notification: Performance of simCode: created event and clocks part: time 2.895e-06/0.6301, allocations: 0 / 0.8624 GB, free: 2.773 MB / 0.6856 GB Notification: Performance of simCode: created simulation system equations: time 0.005507/0.6356, allocations: 1.622 MB / 0.864 GB, free: 1.141 MB / 0.6856 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001693/0.6373, allocations: 361.1 kB / 0.8643 GB, free: 0.8164 MB / 0.6856 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.009932/0.6472, allocations: 4.116 MB / 0.8684 GB, free: 12.66 MB / 0.7012 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0009857/0.6482, allocations: 0.86 MB / 0.8692 GB, free: 11.77 MB / 0.7012 GB Notification: Performance of simCode: alias equations: time 0.002823/0.651, allocations: 0.5667 MB / 0.8697 GB, free: 11.19 MB / 0.7012 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001175/0.6522, allocations: 236.3 kB / 0.87 GB, free: 10.96 MB / 0.7012 GB Notification: Performance of SimCode: time 8.22e-07/0.6522, allocations: 0 / 0.87 GB, free: 10.96 MB / 0.7012 GB Notification: Performance of Templates: time 0.05449/0.7067, allocations: 30.5 MB / 0.8998 GB, free: 12.79 MB / 0.7325 GB " [Timeout remaining time 659] make -j1 -f BuildingSystems_BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez.makefile [Timeout 660] (rm -f BuildingSystems_BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez.pipe ; mkfifo BuildingSystems_BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez.pipe >> ../files/BuildingSystems_BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez.sim & ./BuildingSystems_BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildingSystems_BuildingSystems.BoundaryConditions.SolarIrradiation.Examples.DiffusePerez.pipe 2>&1) [Timeout 480] [Calling sys.exit(0), Time elapsed: 7.466586548835039] Failed to read output from testmodel.py, exit status != 0: 0.7156214490532875 0.73059752 0.308544168 Calling exit ...