INFO: Using directory: "1"
INFO: Using existing c-file: ./ILL_H512_D22.c
INFO: Using existing binary: ./ILL_H512_D22.out
INFO: ===
Simulation 'ILL_H512_D22' (/home/nexmap/pkwi/TESTS/2022-04-01/McStas_8GPU_5e7/ILL_H512_D22/ILL_H512_D22.instr): running on 8 nodes (master is 'hypatia.fysik.dtu.dk', MPI version 3.1).
Have found 1 GPU devices on rank 3. Will use device 0.
Have found 1 GPU devices on rank 1. Will use device 0.
Have found 1 GPU devices on rank 7. Will use device 0.
Have found 1 GPU devices on rank 2. Will use device 0.
Have found 1 GPU devices on rank 4. Will use device 0.
Have found 1 GPU devices on rank 0. Will use device 0.
Have found 1 GPU devices on rank 5. Will use device 0.
ILL_H512_D22: D22:  nu=28307.4 [rpm] lambda=4.5 [Angs] sample=H2O_liq.qSq
ILL_H512_D22: D22:  nu=28307.4 [rpm] lambda=4.5 [Angs] sample=H2O_liq.qSq
ILL_H512_D22: D22:  nu=28307.4 [rpm] lambda=4.5 [Angs] sample=H2O_liq.qSq
ILL_H512_D22: D22:  nu=28307.4 [rpm] lambda=4.5 [Angs] sample=H2O_liq.qSq
ILL_H512_D22: D22:  nu=28307.4 [rpm] lambda=4.5 [Angs] sample=H2O_liq.qSq
ILL_H512_D22: D22:  nu=28307.4 [rpm] lambda=4.5 [Angs] sample=H2O_liq.qSq
ILL_H512_D22: D22:  nu=28307.4 [rpm] lambda=4.5 [Angs] sample=H2O_liq.qSq
[ILL_H512_D22] Initialize
[ILL_H512_D22] Initialize
[ILL_H512_D22] Initialize
[ILL_H512_D22] Initialize
Have found 1 GPU devices on rank 6. Will use device 0.
[ILL_H512_D22] Initialize
[ILL_H512_D22] Initialize
[ILL_H512_D22] Initialize
Source_gen: component HCS (square 0.1 x 0.1)
            focusing distance dist=2.155 area=0.123 x 0.12
            spectra 4.050 to 4.950 AA (3.339 to 4.988 meV)
            T1=40.1 K (4.865 AA), T2=145.8 K (2.552 AA), T3=413.5 K (1.515 AA)
  Flux is dPhi/dlambda in [n/s/cm2].
Opening input file '/u/data/pkwi/McStas/mcstas/3.x-dev/tools/Python/mcrun/../mccodelib/../../../data/Al.laz' (Table_Read_Offset)
ILL_H512_D22: D22:  nu=28307.4 [rpm] lambda=4.5 [Angs] sample=H2O_liq.qSq
[ILL_H512_D22] Initialize
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al: Reading 26 rows from Al.laz
PowderN: HCS_Al: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Opening input file '/u/data/pkwi/McStas/mcstas/3.x-dev/tools/Python/mcrun/../mccodelib/../../../data/Al.laz' (Table_Read_Offset)
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al_4: Reading 26 rows from Al.laz
PowderN: HCS_Al_4: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al_4: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Opening input file '/u/data/pkwi/McStas/mcstas/3.x-dev/tools/Python/mcrun/../mccodelib/../../../data/Al.laz' (Table_Read_Offset)
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al_5: Reading 26 rows from Al.laz
PowderN: HCS_Al_5: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al_5: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Opening input file '/u/data/pkwi/McStas/mcstas/3.x-dev/tools/Python/mcrun/../mccodelib/../../../data/Al.laz' (Table_Read_Offset)
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al_6: Reading 26 rows from Al.laz
PowderN: HCS_Al_6: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al_6: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Opening input file '/u/data/pkwi/McStas/mcstas/3.x-dev/tools/Python/mcrun/../mccodelib/../../../data/Al.laz' (Table_Read_Offset)
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al_7: Reading 26 rows from Al.laz
PowderN: HCS_Al_7: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al_7: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al_15: Reading 26 rows from Al.laz
PowderN: HCS_Al_15: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al_15: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Opening input file '/u/data/pkwi/McStas/mcstas/3.x-dev/tools/Python/mcrun/../mccodelib/../../../data/Al.laz' (Table_Read_Offset)
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al_17: Reading 26 rows from Al.laz
PowderN: HCS_Al_17: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al_17: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al_H51: Reading 26 rows from Al.laz
PowderN: HCS_Al_H51: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al_H51: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al_H512: Reading 26 rows from Al.laz
PowderN: HCS_Al_H512: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al_H512: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Opening input file '/u/data/pkwi/McStas/mcstas/3.x-dev/tools/Python/mcrun/../mccodelib/../../../data/Al.laz' (Table_Read_Offset)
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al_45: Reading 26 rows from Al.laz
PowderN: HCS_Al_45: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al_45: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al_50: Reading 26 rows from Al.laz
PowderN: HCS_Al_50: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al_50: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Table from file 'Al.laz' (block 1) is 26 x 18 (x=1:8), constant step. interpolation: linear
  '# TITLE *Aluminum-Al-[FM3-M] Miller, H.P.jr.;DuMond, J.W.M.[1942] at 298 K; ...'
PowderN: HCS_Al_52: Reading 26 rows from Al.laz
PowderN: HCS_Al_52: Read 26 reflections from file 'Al.laz'
PowderN: HCS_Al_52: Vc=66.4 [Angs] sigma_abs=0.924 [barn] sigma_inc=0.0328 [barn] reflections=Al.laz
Isotropic_Sqw: H51_D22_Sample: is a cylinder: radius=0.005000 thickness=0.000000 height=0.050000 [J Comp Phys 228 (2009) 5251]
Isotropic_Sqw: H51_D22_Sample: Computing scattering unit density V_rho=0.0332279 [AA^-3] from density=0.994 [g/cm^3] weight=18.015 [g/mol].
Isotropic_sqw: Converting 150 S(q) from H2O_liq.qSq into S(q,w) data
Isotropic_sqw: q range [0:14.8], creating 150 elements vector
Isotropic_Sqw: H51_D22_Sample: Temperature set to T=293 [K]
Isotropic_Sqw: H51_D22_Sample: Applying exp(hw/2kT) factor with T=293 [K] on H2O_liq.qSq file (classical/symmetric) using 'Frommhold' quantum correction
Isotropic_Sqw: H51_D22_Sample: Generated H2O_liq.qSq coherent Sqw
                   q=[0:14.8 Angs-1] w=[0:0 meV] |S|=1.49025 size=[152x1] sigma=7.751 [barns]
               Mainly elastic scattering.
Isotropic_Sqw: H51_D22_Sample: Using Isotropic elastic incoherent scattering (sigma=160.521 [barns])
Isotropic_Sqw: H51_D22_Sample: Focusing can only apply for single
               scattering. Setting to order=1.
*** TRACE end *** 

Save [ILL_H512_D22]
Detector: H5_I=6.10406e+12 H5_ERR=1.0019e+09 H5_N=3.83728e+07 "H5_1648771023.x_y"
Detector: H51_origin_I=1.00307e+12 H51_origin_ERR=4.06278e+08 H51_origin_N=6.28776e+06 "H51_origin_1648771023.hd_vd"
Detector: H51_Obt_Out_I=1.15622e+11 H51_Obt_Out_ERR=1.35257e+08 H51_Obt_Out_N=2.72842e+06 "H51_Obt_Out_1648771023.x_y"
Detector: H51_S2_Out_I=8.88673e+10 H51_S2_Out_ERR=1.24363e+08 H51_S2_Out_N=2.32226e+06 "H51_S2_Out_1648771023.x_y"
Detector: H51_split_2_I=4.10849e+10 H51_split_2_ERR=8.46825e+07 H51_split_2_N=1.06314e+06 "H51_split_2_1648771023.x_y"
Detector: H51_split_1_I=4.09241e+10 H51_split_1_ERR=8.44923e+07 H51_split_1_N=1.06352e+06 "H51_split_1_1648771023.x_y"
Detector: H512_VTE_I=2.93149e+10 H512_VTE_ERR=7.33235e+07 H512_VTE_N=973479 "H512_VTE_1648771023.x_y"
Detector: D22_PreV_I=2.40506e+10 D22_PreV_ERR=7.11023e+07 D22_PreV_N=695604 "D22_PreV_1648771023.x_y"
Detector: H51_D22_Sample_Div_I=2.164e+09 H51_D22_Sample_Div_ERR=1.71829e+07 H51_D22_Sample_Div_N=58534 "H51_D22_Sample_Div_1648771023.hd_vd"
Detector: H51_D22_Sample_XY_I=2.164e+09 H51_D22_Sample_XY_ERR=1.71829e+07 H51_D22_Sample_XY_N=58534 "H51_D22_Sample_XY_1648771023.x_y"
Detector: H51_D22_Sample_L_I=2.164e+09 H51_D22_Sample_L_ERR=1.71829e+07 H51_D22_Sample_L_N=58534 "H51_D22_Sample_L_1648771023.L"

Finally [ILL_H512_D22: 1]. Time: 3 [s] 

Finally [ILL_H512_D22: 1]. Time: 2 [s] 

Finally [ILL_H512_D22: 1]. Time: 3 [s] 

Finally [ILL_H512_D22: 1]. Time: 3 [s] 

Finally [ILL_H512_D22: 1]. Time: 2 [s] 

Finally [ILL_H512_D22: 1]. Time: 2 [s] 
Detector: D22_Detector_I=1.9332e+07 D22_Detector_ERR=263195 D22_Detector_N=21542 "D22_Detector_1648771023.x_y"

Finally [ILL_H512_D22: 1]. Time: 2 [s] 

Finally [ILL_H512_D22: 1]. Time: 2 [s] 
Isotropic_Sqw: H51_D22_Sample: 445 neutron events (out of 182863) that should have
               scattered were transmitted because scattering conditions
WARNING        could not be satisfied after 100 tries.
Isotropic_Sqw: H51_D22_Sample: Scattering fraction=0.971136 of incoming intensity
               Absorption fraction           =0.0097869
               Single   scattering intensity =1.5395e+08 (coh=1.07276e+07 inc=1.43223e+08)
               Multiple scattering intensity =0
INFO: Placing instr file copy /home/nexmap/pkwi/TESTS/2022-04-01/McStas_8GPU_5e7/ILL_H512_D22/ILL_H512_D22.instr in dataset 1
loading system configuration
loading override configuration from /home/nexmap/pkwi/McCode/tools/Python/mctest/../mccodelib/mcstas-test/McStas_8GPU/mccode_config.json