| Name | JjkMDm7fcSvnShfckohDCDFpABFKDmABFKDmQ6FKDm1DFKDmN7WHWo_2 |
| Workunit | 1937884 |
| Created | 20 Sep 2019, 21:47:24 UTC |
| Sent | 21 Sep 2019, 15:37:16 UTC |
| Report deadline | 28 Sep 2019, 15:37:16 UTC |
| Received | 5 Oct 2019, 21:18:06 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 3839 |
| Run time | 3 days 7 hours 47 min 5 sec |
| CPU time | 1 hours 21 min 26 sec |
| Validate state | Valid |
| Credit | 4,151.08 |
| Device peak FLOPS | 6.24 GFLOPS |
| Application version | ATLAS Simulation v0.86 (vbox64_mt_mcore_atlas) windows_x86_64 |
| Peak working set size | 91.87 MB |
| Peak swap size | 141.08 MB |
| Peak disk usage | 4.07 GB |
Stderr output
<core_client_version>7.14.2</core_client_version> <![CDATA[ <stderr_txt> 2019-09-21 23:12:55 (4956): Detected: vboxwrapper 26197 2019-09-21 23:12:55 (4956): Detected: BOINC client v7.7 2019-09-21 23:12:56 (4956): Detected: VirtualBox VboxManage Interface (Version: 5.2.30) 2019-09-21 23:12:56 (4956): Successfully copied 'init_data.xml' to the shared directory. 2019-09-21 23:12:57 (4956): Create VM. (boinc_a4826a5894ca1b28, slot#0) 2019-09-21 23:12:58 (4956): Setting Memory Size for VM. (4800MB) 2019-09-21 23:12:58 (4956): Setting CPU Count for VM. (2) 2019-09-21 23:12:58 (4956): Setting Chipset Options for VM. 2019-09-21 23:12:59 (4956): Setting Boot Options for VM. 2019-09-21 23:12:59 (4956): Setting Network Configuration for NAT. 2019-09-21 23:12:59 (4956): Enabling VM Network Access. 2019-09-21 23:12:59 (4956): Disabling USB Support for VM. 2019-09-21 23:13:00 (4956): Disabling COM Port Support for VM. 2019-09-21 23:13:00 (4956): Disabling LPT Port Support for VM. 2019-09-21 23:13:00 (4956): Disabling Audio Support for VM. 2019-09-21 23:13:00 (4956): Disabling Clipboard Support for VM. 2019-09-21 23:13:01 (4956): Disabling Drag and Drop Support for VM. 2019-09-21 23:13:01 (4956): Adding storage controller(s) to VM. 2019-09-21 23:13:01 (4956): Adding virtual disk drive to VM. (vm_image.vdi) 2019-09-21 23:13:02 (4956): Adding VirtualBox Guest Additions to VM. 2019-09-21 23:13:02 (4956): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2019-09-21 23:13:02 (4956): forwarding host port 53695 to guest port 80 2019-09-21 23:13:02 (4956): Enabling remote desktop for VM. 2019-09-21 23:13:03 (4956): Enabling shared directory for VM. 2019-09-21 23:13:03 (4956): Starting VM using VBoxManage interface. (boinc_a4826a5894ca1b28, slot#0) 2019-09-21 23:13:08 (4956): Successfully started VM. (PID = '4492') 2019-09-21 23:13:08 (4956): Reporting VM Process ID to BOINC. 2019-09-21 23:13:08 (4956): Guest Log: BIOS: VirtualBox 5.2.30 2019-09-21 23:13:08 (4956): Guest Log: CPUID EDX: 0x178bfbff 2019-09-21 23:13:08 (4956): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-21 23:13:08 (4956): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-09-21 23:13:08 (4956): Detected: Web Application Enabled (http://localhost:53695) 2019-09-21 23:13:08 (4956): Detected: Remote Desktop Enabled (localhost:53696) 2019-09-21 23:13:08 (4956): Preference change detected 2019-09-21 23:13:08 (4956): Setting CPU throttle for VM. (100%) 2019-09-21 23:13:08 (4956): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 900 seconds)) 2019-09-21 23:13:10 (4956): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-21 23:13:10 (4956): Guest Log: BIOS: Booting from Hard Disk... 2019-09-21 23:13:12 (4956): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-21 23:13:12 (4956): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2019-09-21 23:13:12 (4956): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2019-09-21 23:13:18 (4956): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-21 23:13:18 (4956): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-21 23:13:21 (4956): Guest Log: Checking CVMFS... 2019-09-21 23:13:27 (4956): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.000254 main Log opened 2019-09-21T23:13:25.833637000Z 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.000397 main OS Product: Linux 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.000474 main OS Release: 3.10.0-957.27.2.el7.x86_64 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.000523 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.000588 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.000590 main Process ID: 1488 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.000590 main Package type: LINUX_64BITS_GENERIC 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.017682 main 5.2.32 r132073 started. Verbose level = 0 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.025653 main Error: Service 'control' failed to initialize: VERR_INVALID_PARAMETER 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.025829 main Session 0 is about to close ... 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.025879 main Stopping all guest processes ... 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.025927 main Closing all guest files ... 2019-09-21 23:13:27 (4956): Guest Log: 00:00:00.026292 main Ended. 2019-09-21 23:13:30 (4956): Guest Log: CVMFS is ok 2019-09-21 23:13:30 (4956): Guest Log: Mounting shared directory 2019-09-21 23:13:30 (4956): Guest Log: Copying input files 2019-09-21 23:13:32 (4956): Guest Log: Copied input files into RunAtlas. 2019-09-21 23:13:33 (4956): Guest Log: copied the webapp to /var/www 2019-09-21 23:13:33 (4956): Guest Log: This vm does not need to setup an http proxy 2019-09-21 23:13:33 (4956): Guest Log: ATHENA_PROC_NUMBER=2 2019-09-21 23:13:33 (4956): Guest Log: *** Starting ATLAS job. (PandaID=4002876565 taskID=000649-2) *** 2019-09-22 17:33:02 (4956): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-22 17:33:02 (4956): Stopping VM. 2019-09-24 22:10:26 (5292): Detected: vboxwrapper 26197 2019-09-24 22:10:26 (5292): Detected: BOINC client v7.7 2019-09-24 22:10:27 (5292): Detected: VirtualBox VboxManage Interface (Version: 5.2.30) 2019-09-24 22:10:28 (5292): Starting VM using VBoxManage interface. (boinc_a4826a5894ca1b28, slot#0) 2019-09-24 22:10:35 (5292): Successfully started VM. (PID = '2028') 2019-09-24 22:10:35 (5292): Reporting VM Process ID to BOINC. 2019-09-24 22:10:35 (5292): Guest Log: BIOS: VirtualBox 5.2.30 2019-09-24 22:10:35 (5292): Guest Log: CPUID EDX: 0x178bfbff 2019-09-24 22:10:35 (5292): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-24 22:10:35 (5292): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-09-24 22:10:35 (5292): Detected: Web Application Enabled (http://localhost:53695) 2019-09-24 22:10:35 (5292): Detected: Remote Desktop Enabled (localhost:53696) 2019-09-24 22:10:35 (5292): Preference change detected 2019-09-24 22:10:35 (5292): Setting CPU throttle for VM. (100%) 2019-09-24 22:10:35 (5292): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 900 seconds)) 2019-09-24 22:10:37 (5292): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-24 22:10:37 (5292): Guest Log: BIOS: Booting from Hard Disk... 2019-09-24 22:10:40 (5292): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-24 22:10:40 (5292): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2019-09-24 22:10:40 (5292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2019-09-24 22:10:55 (5292): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-24 22:10:55 (5292): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-24 22:11:08 (5292): Guest Log: Checking CVMFS... 2019-09-24 22:11:10 (5292): Guest Log: Failed to check CVMFS, check output from cvmfs_config probe: 2019-09-24 22:11:11 (5292): Guest Log: Probing /cvmfs/atlas.cern.ch... Failed! 2019-09-24 22:11:11 (5292): Guest Log: Probing /cvmfs/atlas-condb.cern.ch... Failed! 2019-09-24 22:11:11 (5292): Guest Log: Probing /cvmfs/grid.cern.ch... Failed! 2019-09-24 22:11:36 (5292): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.000190 main Log opened 2019-09-24T22:11:32.965724000Z 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.000309 main OS Product: Linux 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.000361 main OS Release: 3.10.0-957.27.2.el7.x86_64 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.000399 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.000436 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.000437 main Process ID: 1646 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.000438 main Package type: LINUX_64BITS_GENERIC 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.002466 main 5.2.32 r132073 started. Verbose level = 0 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.006560 main Error: Service 'control' failed to initialize: VERR_INVALID_PARAMETER 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.006745 main Session 0 is about to close ... 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.006788 main Stopping all guest processes ... 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.006828 main Closing all guest files ... 2019-09-24 22:11:36 (5292): Guest Log: 00:00:00.007087 main Ended. 2019-09-24 23:24:57 (5292): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-25 18:31:23 (5292): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_a4826a5894ca1b28" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-09-25 18:31:24 (5292): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-25 18:49:14 (5292): Status Report: Elapsed Time: '6000.153528' 2019-09-25 18:49:14 (5292): Status Report: CPU Time: '533.211418' 2019-09-25 20:29:16 (5292): Status Report: Elapsed Time: '12001.153528' 2019-09-25 20:29:16 (5292): Status Report: CPU Time: '548.858318' 2019-09-25 22:09:16 (5292): Status Report: Elapsed Time: '18001.153528' 2019-09-25 22:09:16 (5292): Status Report: CPU Time: '564.286817' 2019-09-25 22:26:06 (5292): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-26 18:23:12 (5292): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_a4826a5894ca1b28" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-09-26 18:23:12 (5292): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-26 19:46:24 (5292): Status Report: Elapsed Time: '24001.153528' 2019-09-26 19:46:24 (5292): Status Report: CPU Time: '581.571728' 2019-09-26 21:26:24 (5292): Status Report: Elapsed Time: '30001.153528' 2019-09-26 21:26:24 (5292): Status Report: CPU Time: '598.872239' 2019-09-26 22:50:47 (5292): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-27 18:42:56 (5292): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_a4826a5894ca1b28" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-09-27 18:42:57 (5292): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-27 18:58:35 (5292): Status Report: Elapsed Time: '36002.153528' 2019-09-27 18:58:35 (5292): Status Report: CPU Time: '616.734353' 2019-09-27 20:38:35 (5292): Status Report: Elapsed Time: '42002.153528' 2019-09-27 20:38:35 (5292): Status Report: CPU Time: '633.644862' 2019-09-27 22:18:36 (5292): Status Report: Elapsed Time: '48002.153528' 2019-09-27 22:18:36 (5292): Status Report: CPU Time: '650.726971' 2019-09-27 23:35:15 (5292): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-28 10:27:15 (5292): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_a4826a5894ca1b28" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-09-28 10:27:17 (5292): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-28 10:50:38 (5292): Status Report: Elapsed Time: '54002.153528' 2019-09-28 10:50:38 (5292): Status Report: CPU Time: '668.074282' 2019-09-28 12:30:38 (5292): Status Report: Elapsed Time: '60002.153528' 2019-09-28 12:30:38 (5292): Status Report: CPU Time: '685.312393' 2019-09-28 14:10:39 (5292): Status Report: Elapsed Time: '66002.153528' 2019-09-28 14:10:39 (5292): Status Report: CPU Time: '702.815705' 2019-09-28 15:50:39 (5292): Status Report: Elapsed Time: '72002.153528' 2019-09-28 15:50:39 (5292): Status Report: CPU Time: '720.303417' 2019-09-28 17:30:40 (5292): Status Report: Elapsed Time: '78002.153528' 2019-09-28 17:30:40 (5292): Status Report: CPU Time: '737.291926' 2019-09-28 19:10:40 (5292): Status Report: Elapsed Time: '84002.153528' 2019-09-28 19:10:40 (5292): Status Report: CPU Time: '754.374035' 2019-09-28 20:50:40 (5292): Status Report: Elapsed Time: '90002.153528' 2019-09-28 20:50:40 (5292): Status Report: CPU Time: '772.111349' 2019-09-28 22:30:41 (5292): Status Report: Elapsed Time: '96002.153528' 2019-09-28 22:30:41 (5292): Status Report: CPU Time: '789.287059' 2019-09-28 23:58:14 (5292): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-29 10:13:53 (5292): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_a4826a5894ca1b28" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-09-29 10:13:54 (5292): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-29 10:26:21 (5292): Status Report: Elapsed Time: '102002.153528' 2019-09-29 10:26:21 (5292): Status Report: CPU Time: '807.102374' 2019-09-29 12:06:22 (5292): Status Report: Elapsed Time: '108002.153528' 2019-09-29 12:06:22 (5292): Status Report: CPU Time: '824.106482' 2019-09-29 13:46:22 (5292): Status Report: Elapsed Time: '114002.153528' 2019-09-29 13:46:22 (5292): Status Report: CPU Time: '843.279005' 2019-09-29 15:26:23 (5292): Status Report: Elapsed Time: '120002.153528' 2019-09-29 15:26:23 (5292): Status Report: CPU Time: '863.340734' 2019-09-29 17:06:23 (5292): Status Report: Elapsed Time: '126002.153528' 2019-09-29 17:06:23 (5292): Status Report: CPU Time: '882.419656' 2019-09-29 18:46:50 (5292): Status Report: Elapsed Time: '132002.153528' 2019-09-29 18:46:50 (5292): Status Report: CPU Time: '901.514179' 2019-09-29 20:26:50 (5292): Status Report: Elapsed Time: '138002.153528' 2019-09-29 20:26:50 (5292): Status Report: CPU Time: '921.076704' 2019-09-29 22:06:51 (5292): Status Report: Elapsed Time: '144002.153528' 2019-09-29 22:06:51 (5292): Status Report: CPU Time: '940.405228' 2019-09-29 22:51:54 (5292): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-30 18:50:27 (5292): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_a4826a5894ca1b28" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-09-30 18:50:28 (5292): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-30 19:45:26 (5292): Status Report: Elapsed Time: '150002.153528' 2019-09-30 19:45:26 (5292): Status Report: CPU Time: '960.061354' 2019-09-30 21:25:26 (5292): Status Report: Elapsed Time: '156002.153528' 2019-09-30 21:25:26 (5292): Status Report: CPU Time: '979.904681' 2019-09-30 23:05:27 (5292): Status Report: Elapsed Time: '162002.153528' 2019-09-30 23:05:27 (5292): Status Report: CPU Time: '999.373606' 2019-09-30 23:11:44 (5292): VM state change detected. (old = 'Running', new = 'Paused') 2019-10-01 18:36:30 (5292): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_a4826a5894ca1b28" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-10-01 18:36:31 (5292): VM state change detected. (old = 'Paused', new = 'Running') 2019-10-01 20:10:14 (5292): Status Report: Elapsed Time: '168002.153528' 2019-10-01 20:10:14 (5292): Status Report: CPU Time: '1020.106139' 2019-10-01 21:50:15 (5292): Status Report: Elapsed Time: '174002.153528' 2019-10-01 21:50:15 (5292): Status Report: CPU Time: '1038.295856' 2019-10-01 23:15:52 (5292): VM state change detected. (old = 'Running', new = 'Paused') 2019-10-02 18:28:02 (5292): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_a4826a5894ca1b28" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-10-02 18:28:03 (5292): VM state change detected. (old = 'Paused', new = 'Running') 2019-10-02 18:42:26 (5292): Status Report: Elapsed Time: '180002.153528' 2019-10-02 18:42:26 (5292): Status Report: CPU Time: '1063.661618' 2019-10-02 20:22:26 (5292): Status Report: Elapsed Time: '186002.153528' 2019-10-02 20:22:26 (5292): Status Report: CPU Time: '1084.238150' 2019-10-02 22:02:27 (5292): Status Report: Elapsed Time: '192002.153528' 2019-10-02 22:02:27 (5292): Status Report: CPU Time: '1103.816275' 2019-10-02 23:42:27 (5292): Status Report: Elapsed Time: '198002.153528' 2019-10-02 23:42:27 (5292): Status Report: CPU Time: '1124.002805' 2019-10-03 01:00:54 (5292): VM state change detected. (old = 'Running', new = 'Paused') 2019-10-03 12:51:28 (5292): VM state change detected. (old = 'Paused', new = 'Running') 2019-10-03 13:13:02 (5292): Status Report: Elapsed Time: '204002.153528' 2019-10-03 13:13:02 (5292): Status Report: CPU Time: '1144.095734' 2019-10-03 14:53:03 (5292): Status Report: Elapsed Time: '210002.153528' 2019-10-03 14:53:03 (5292): Status Report: CPU Time: '1163.861060' 2019-10-03 16:33:03 (5292): Status Report: Elapsed Time: '216002.153528' 2019-10-03 16:33:03 (5292): Status Report: CPU Time: '1184.094390' 2019-10-03 18:13:04 (5292): Status Report: Elapsed Time: '222002.153528' 2019-10-03 18:13:04 (5292): Status Report: CPU Time: '1204.156119' 2019-10-03 19:53:04 (5292): Status Report: Elapsed Time: '228002.153528' 2019-10-03 19:53:04 (5292): Status Report: CPU Time: '1221.815432' 2019-10-03 21:33:05 (5292): Status Report: Elapsed Time: '234002.153528' 2019-10-03 21:33:05 (5292): Status Report: CPU Time: '1239.583946' 2019-10-03 23:13:05 (5292): Status Report: Elapsed Time: '240002.153528' 2019-10-03 23:13:05 (5292): Status Report: CPU Time: '1256.790856' 2019-10-03 23:37:33 (5292): VM state change detected. (old = 'Running', new = 'Paused') 2019-10-04 12:48:13 (5292): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_a4826a5894ca1b28" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-10-04 12:48:14 (5292): VM state change detected. (old = 'Paused', new = 'Running') 2019-10-04 14:03:48 (5292): Status Report: Elapsed Time: '246002.153528' 2019-10-04 14:03:48 (5292): Status Report: CPU Time: '1274.434569' 2019-10-04 15:43:48 (5292): Status Report: Elapsed Time: '252002.153528' 2019-10-04 15:43:48 (5292): Status Report: CPU Time: '1291.875481' 2019-10-04 17:23:49 (5292): Status Report: Elapsed Time: '258002.153528' 2019-10-04 17:23:49 (5292): Status Report: CPU Time: '1309.004391' 2019-10-04 19:03:49 (5292): Status Report: Elapsed Time: '264002.153528' 2019-10-04 19:03:49 (5292): Status Report: CPU Time: '1326.850905' 2019-10-04 20:43:50 (5292): Status Report: Elapsed Time: '270002.153528' 2019-10-04 20:43:50 (5292): Status Report: CPU Time: '1344.759820' 2019-10-04 22:23:50 (5292): Status Report: Elapsed Time: '276002.153528' 2019-10-04 22:23:50 (5292): Status Report: CPU Time: '1361.904330' 2019-10-05 00:03:51 (5292): Status Report: Elapsed Time: '282002.153528' 2019-10-05 00:03:51 (5292): Status Report: CPU Time: '1378.986439' 2019-10-05 00:24:07 (5292): VM state change detected. (old = 'Running', new = 'Paused') 2019-10-05 03:00:53 (5292): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_a4826a5894ca1b28" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-10-05 03:00:54 (5292): VM state change detected. (old = 'Paused', new = 'Running') 2019-10-05 20:37:08 (3936): Detected: vboxwrapper 26197 2019-10-05 20:37:08 (3936): Detected: BOINC client v7.7 2019-10-05 20:37:10 (3936): Detected: VirtualBox VboxManage Interface (Version: 5.2.30) 2019-10-05 20:37:11 (3936): Starting VM using VBoxManage interface. (boinc_a4826a5894ca1b28, slot#0) 2019-10-05 20:37:20 (3936): Successfully started VM. (PID = '4308') 2019-10-05 20:37:20 (3936): Reporting VM Process ID to BOINC. 2019-10-05 20:37:20 (3936): Guest Log: BIOS: VirtualBox 5.2.30 2019-10-05 20:37:20 (3936): Guest Log: CPUID EDX: 0x178bfbff 2019-10-05 20:37:20 (3936): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-10-05 20:37:20 (3936): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-10-05 20:37:20 (3936): Detected: Web Application Enabled (http://localhost:53695) 2019-10-05 20:37:20 (3936): Detected: Remote Desktop Enabled (localhost:53696) 2019-10-05 20:37:20 (3936): Status Report: Elapsed Time: '284308.153528' 2019-10-05 20:37:20 (3936): Status Report: CPU Time: '1386.006484' 2019-10-05 20:37:20 (3936): Preference change detected 2019-10-05 20:37:20 (3936): Setting CPU throttle for VM. (100%) 2019-10-05 20:37:20 (3936): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 900 seconds)) 2019-10-05 20:37:22 (3936): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-10-05 20:37:22 (3936): Guest Log: BIOS: Booting from Hard Disk... 2019-10-05 20:37:25 (3936): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-10-05 20:37:25 (3936): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2019-10-05 20:37:25 (3936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2019-10-05 20:37:35 (3936): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-10-05 20:37:35 (3936): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-10-05 20:37:43 (3936): Guest Log: Checking CVMFS... 2019-10-05 20:37:44 (3936): Guest Log: Failed to check CVMFS, check output from cvmfs_config probe: 2019-10-05 20:37:56 (3936): Guest Log: Probing /cvmfs/atlas.cern.ch... OK 2019-10-05 20:37:57 (3936): Guest Log: Probing /cvmfs/atlas-condb.cern.ch... OK 2019-10-05 20:37:58 (3936): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.000330 main Log opened 2019-10-05T20:37:57.016840000Z 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.000518 main OS Product: Linux 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.000779 main OS Release: 3.10.0-957.27.2.el7.x86_64 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.001494 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.001593 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.001594 main Process ID: 1897 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.001595 main Package type: LINUX_64BITS_GENERIC 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.003822 main 5.2.32 r132073 started. Verbose level = 0 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.005552 main Error: Service 'control' failed to initialize: VERR_INVALID_PARAMETER 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.005722 main Session 0 is about to close ... 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.005771 main Stopping all guest processes ... 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.005835 main Closing all guest files ... 2019-10-05 20:37:58 (3936): Guest Log: 00:00:00.006357 main Ended. 2019-10-05 20:37:59 (3936): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-10-05 20:37:59 (3936): Guest Log: Mounting shared directory 2019-10-05 20:38:00 (3936): Guest Log: Copying input files 2019-10-05 20:38:06 (3936): Guest Log: Copied input files into RunAtlas. 2019-10-05 20:38:10 (3936): Guest Log: copied the webapp to /var/www 2019-10-05 20:38:10 (3936): Guest Log: This vm does not need to setup an http proxy 2019-10-05 20:38:10 (3936): Guest Log: ATHENA_PROC_NUMBER=2 2019-10-05 20:38:10 (3936): Guest Log: *** Starting ATLAS job. (PandaID=4002876565 taskID=000649-2) *** 2019-10-05 20:41:29 (3936): Stopping VM. 2019-10-05 22:27:02 (3380): Detected: vboxwrapper 26197 2019-10-05 22:27:02 (3380): Detected: BOINC client v7.7 2019-10-05 22:27:07 (3380): Detected: VirtualBox VboxManage Interface (Version: 5.2.30) 2019-10-05 22:27:08 (3380): Starting VM using VBoxManage interface. (boinc_a4826a5894ca1b28, slot#0) 2019-10-05 22:33:05 (3332): Detected: vboxwrapper 26197 2019-10-05 22:33:05 (3332): Detected: BOINC client v7.7 2019-10-05 22:33:09 (3332): Detected: VirtualBox VboxManage Interface (Version: 5.2.30) 2019-10-05 22:33:11 (3332): Starting VM using VBoxManage interface. (boinc_a4826a5894ca1b28, slot#0) 2019-10-05 22:33:35 (3332): Successfully started VM. (PID = '4048') 2019-10-05 22:33:35 (3332): Reporting VM Process ID to BOINC. 2019-10-05 22:33:35 (3332): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-10-05 22:33:35 (3332): Detected: Web Application Enabled (http://localhost:53695) 2019-10-05 22:33:35 (3332): Detected: Remote Desktop Enabled (localhost:53696) 2019-10-05 22:33:35 (3332): Status Report: Elapsed Time: '284557.153528' 2019-10-05 22:33:35 (3332): Status Report: CPU Time: '1505.191248' 2019-10-05 22:33:35 (3332): Preference change detected 2019-10-05 22:33:35 (3332): Setting CPU throttle for VM. (100%) 2019-10-05 22:33:35 (3332): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 900 seconds)) 2019-10-05 23:12:22 (3332): Guest Log: *** Job finished *** 2019-10-05 23:12:22 (3332): Guest Log: *** The last 20 lines of the pilot log: *** 2019-10-05 23:12:22 (3332): Guest Log: 2019-10-05 21:20:19 UTC [wrapper] apfmon messages muted 2019-10-05 23:12:22 (3332): Guest Log: ---- find pandaID.out ---- 2019-10-05 23:12:22 (3332): Guest Log: total 56 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 11357 Jul 25 14:38 LICENSE 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 20 Sep 9 11:04 MANIFEST.IN 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 11 Oct 5 20:39 pandaIDs.out 2019-10-05 23:12:22 (3332): Guest Log: drwx------. 14 atlas atlas 216 Oct 5 20:39 pilot 2019-10-05 23:12:22 (3332): Guest Log: -rwx------. 1 atlas atlas 20136 Sep 9 11:04 pilot.py 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 9 Sep 9 11:04 PILOTVERSION 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 2251 Jul 25 14:38 README.md 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 760 Aug 22 09:01 setup.py 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 221 Jul 25 14:38 TODO.md 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 11 Oct 5 20:39 /home/atlas/RunAtlas/pilot2/pandaIDs.out 2019-10-05 23:12:22 (3332): Guest Log: 4002876565 2019-10-05 23:12:22 (3332): Guest Log: 2019-10-05 21:20:19 UTC [wrapper] Test setup, not cleaning 2019-10-05 23:12:22 (3332): Guest Log: 2019-10-05 21:20:19 UTC [wrapper] ==== wrapper stdout END ==== 2019-10-05 23:12:22 (3332): Guest Log: 2019-10-05 21:20:19 UTC [wrapper] ==== wrapper stderr END ==== 2019-10-05 23:12:22 (3332): Guest Log: 2019-10-05 21:20:19 UTC [wrapper] wrapper wrapperexiting ec=0, duration=2531 2019-10-05 23:12:22 (3332): Guest Log: 2019-10-05 21:20:19 UTC [wrapper] apfmon messages muted 2019-10-05 23:12:22 (3332): Guest Log: *** Error codes and diagnostics *** 2019-10-05 23:12:22 (3332): Guest Log: "exeErrorCode": 0, 2019-10-05 23:12:22 (3332): Guest Log: "exeErrorDiag": "", 2019-10-05 23:12:22 (3332): Guest Log: "pilotErrorCode": 0, 2019-10-05 23:12:22 (3332): Guest Log: "pilotErrorDiag": "", 2019-10-05 23:12:22 (3332): Guest Log: *** Listing of results directory *** 2019-10-05 23:12:22 (3332): Guest Log: total 22276 2019-10-05 23:12:22 (3332): Guest Log: -rw-r--r--. 1 atlas atlas 259319 Sep 12 11:38 pilot2.tar.gz 2019-10-05 23:12:22 (3332): Guest Log: -rwx------. 1 atlas atlas 12641 Sep 12 11:42 runpilot2-wrapper.sh 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 2958 Sep 12 11:42 pandaJobData.out 2019-10-05 23:12:22 (3332): Guest Log: -rwxr-xr-x. 1 atlas atlas 5935 Oct 5 20:38 init_data.xml 2019-10-05 23:12:22 (3332): Guest Log: -rwxr-xr-x. 1 atlas atlas 266070 Oct 5 20:38 input.tar.gz 2019-10-05 23:12:22 (3332): Guest Log: -rwxr-xr-x. 1 atlas atlas 815 Oct 5 20:38 RTE.tar.gz 2019-10-05 23:12:22 (3332): Guest Log: -rwxr-xr-x. 1 atlas atlas 8465 Oct 5 20:38 start_atlas.sh 2019-10-05 23:12:22 (3332): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Oct 5 20:38 EVNT.14296418._001447.pool.root.1 -> /data/./ATLAS.root_0 2019-10-05 23:12:22 (3332): Guest Log: drwxr-xr-x. 3 atlas atlas 17 Oct 5 20:38 APPS 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 5077 Oct 5 20:39 queuedata.json 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 3958599 Oct 5 20:39 agis_schedconf.cvmfs.json 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 7586632 Oct 5 20:39 agis_ddmendpoints.json 2019-10-05 23:12:22 (3332): Guest Log: drwx------. 3 atlas atlas 229 Oct 5 20:39 pilot2 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 9090858 Oct 5 21:18 HITS.000649-2898937-14114._078090.pool.root.1 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 784 Oct 5 21:19 memory_monitor_summary.json 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 517637 Oct 5 21:19 log.000649-2898937-14114._078090.job.log.tgz.1 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 10978 Oct 5 21:19 heartbeat.json 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 11380 Oct 5 21:20 pilotlog.txt 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 236688 Oct 5 21:20 log.14568781._078090.job.log.1 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 493 Oct 5 21:20 JjkMDm7fcSvnShfckohDCDFpABFKDmABFKDmQ6FKDm1DFKDmN7WHWo.diag 2019-10-05 23:12:22 (3332): Guest Log: -rw-r--r--. 1 atlas atlas 6802 Oct 5 21:20 runtime_log.err 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 499 Oct 5 21:20 output.list 2019-10-05 23:12:22 (3332): Guest Log: -rw-r--r--. 1 atlas atlas 618 Oct 5 21:20 runtime_log 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 778240 Oct 5 21:20 result.tar.gz 2019-10-05 23:12:22 (3332): Guest Log: Looking for outputfile HITS.000649-2898937-14114._078090.pool.root.1 2019-10-05 23:12:22 (3332): Guest Log: HITS file was successfully produced 2019-10-05 23:12:22 (3332): Guest Log: -rw-------. 1 atlas atlas 9090858 Oct 5 21:18 /home/atlas/RunAtlas/HITS.000649-2898937-14114._078090.pool.root.1 2019-10-05 23:12:22 (3332): Guest Log: Successfully finished the ATLAS job! 2019-10-05 23:12:22 (3332): Guest Log: Copying the results back to the shared directory! 2019-10-05 23:12:22 (3332): Guest Log: *** Contents of shared directory: *** 2019-10-05 23:12:22 (3332): Guest Log: total 366616 2019-10-05 23:12:22 (3332): Guest Log: -rwxrwxrwx. 1 root root 365251149 Sep 21 21:12 ATLAS.root_0 2019-10-05 23:12:22 (3332): Guest Log: -rwxrwxrwx. 1 root root 9090858 Oct 5 21:12 HITS.pool.root.1 2019-10-05 23:12:22 (3332): Guest Log: -rwxrwxrwx. 1 root root 5935 Sep 21 21:12 init_data.xml 2019-10-05 23:12:22 (3332): Guest Log: -rwxrwxrwx. 1 root root 266070 Sep 21 15:40 input.tar.gz 2019-10-05 23:12:22 (3332): Guest Log: -rwxrwxrwx. 1 root root 778240 Oct 5 21:12 result.tar.gz 2019-10-05 23:12:22 (3332): Guest Log: -rwxrwxrwx. 1 root root 815 Sep 21 15:40 RTE.tar.gz 2019-10-05 23:12:22 (3332): Guest Log: -rwxrwxrwx. 1 root root 8465 Sep 21 15:40 start_atlas.sh 2019-10-05 23:12:22 (3332): Guest Log: *** Success! Shutting down the machine. *** 2019-10-05 23:12:22 (3332): VM Completion File Detected. 2019-10-05 23:12:22 (3332): Powering off VM. 2019-10-05 23:17:25 (3332): VM did not power off when requested. 2019-10-05 23:17:25 (3332): VM was successfully terminated. 2019-10-05 23:17:25 (3332): Deregistering VM. (boinc_a4826a5894ca1b28, slot#0) 2019-10-05 23:17:28 (3332): Removing network bandwidth throttle group from VM. 2019-10-05 23:17:29 (3332): Removing VM from VirtualBox. 23:17:34 (3332): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN