Task 2803137

Name	VY2LDmYfzJvnShfckohDCDFpABFKDmABFKDmK2PMDmABFKDmy1sNHn_1
Workunit	1919476
Created	21 Aug 2019, 3:04:12 UTC
Sent	21 Aug 2019, 7:57:06 UTC
Report deadline	28 Aug 2019, 7:57:06 UTC
Received	27 Aug 2019, 15:21:02 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	3390
Run time	6 hours 54 min 15 sec
CPU time	8 hours 46 min 55 sec
Validate state	Valid
Credit	362.66
Device peak FLOPS	13.26 GFLOPS
Application version	ATLAS Simulation v0.60 (vbox64_mt_mcore_atlas) windows_x86_64
Peak working set size	100.93 MB
Peak swap size	138.25 MB
Peak disk usage	6.22 GB
Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-08-21 15:25:43 (20540): vboxwrapper (7.9.26200): starting
2019-08-21 15:25:44 (20540): Feature: Checkpoint interval offset (28 seconds)
2019-08-21 15:25:44 (20540): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-21 15:25:44 (20540): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-21 15:25:44 (20540): Successfully copied 'init_data.xml' to the shared directory.
2019-08-21 15:25:45 (20540): Create VM. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-21 15:25:46 (20540): Setting Memory Size for VM. (5700MB)
2019-08-21 15:25:46 (20540): Setting CPU Count for VM. (3)
2019-08-21 15:25:46 (20540): Setting Chipset Options for VM.
2019-08-21 15:25:47 (20540): Setting Boot Options for VM.
2019-08-21 15:25:47 (20540): Setting Network Configuration for NAT.
2019-08-21 15:25:47 (20540): Enabling VM Network Access.
2019-08-21 15:25:47 (20540): Disabling USB Support for VM.
2019-08-21 15:25:48 (20540): Disabling COM Port Support for VM.
2019-08-21 15:25:48 (20540): Disabling LPT Port Support for VM.
2019-08-21 15:25:48 (20540): Disabling Audio Support for VM.
2019-08-21 15:25:49 (20540): Disabling Clipboard Support for VM.
2019-08-21 15:25:49 (20540): Disabling Drag and Drop Support for VM.
2019-08-21 15:25:49 (20540): Adding storage controller(s) to VM.
2019-08-21 15:25:49 (20540): Adding virtual disk drive to VM. (vm_image.vdi)
2019-08-21 15:25:50 (20540): Adding VirtualBox Guest Additions to VM.
2019-08-21 15:25:50 (20540): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-08-21 15:25:50 (20540): forwarding host port 55228 to guest port 80
2019-08-21 15:25:50 (20540): Enabling remote desktop for VM.
2019-08-21 15:25:51 (20540): Enabling shared directory for VM.
2019-08-21 15:25:51 (20540): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-21 15:25:56 (20540): Successfully started VM. (PID = '14324')
2019-08-21 15:25:56 (20540): Reporting VM Process ID to BOINC.
2019-08-21 15:26:01 (20540): Guest Log: BIOS: VirtualBox 6.0.10

2019-08-21 15:26:01 (20540): Guest Log: CPUID EDX: 0x178bfbfd

2019-08-21 15:26:01 (20540): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-21 15:26:01 (20540): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-21 15:26:01 (20540): Guest Log: BIOS: Booting from Hard Disk...

2019-08-21 15:26:01 (20540): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-21 15:26:01 (20540): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-21 15:26:02 (20540): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-21 15:26:07 (20540): Detected: Web Application Enabled (http://localhost:55228)
2019-08-21 15:26:07 (20540): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-21 15:26:12 (20540): Preference change detected
2019-08-21 15:26:12 (20540): Setting CPU throttle for VM. (25%)
2019-08-21 15:26:12 (20540): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-21 15:26:24 (20540): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-21 15:26:24 (20540): Stopping VM.
2019-08-21 15:26:28 (20540): Successfully stopped VM.
2019-08-23 08:14:50 (4880): vboxwrapper (7.9.26200): starting
2019-08-23 08:14:51 (4880): Feature: Checkpoint interval offset (292 seconds)
2019-08-23 08:14:51 (4880): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-23 08:14:51 (4880): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-23 08:14:52 (4880): Guest Log: BIOS: VirtualBox 6.0.10

2019-08-23 08:14:52 (4880): Guest Log: CPUID EDX: 0x178bfbfd

2019-08-23 08:14:52 (4880): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-23 08:14:52 (4880): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-23 08:14:52 (4880): Guest Log: BIOS: Booting from Hard Disk...

2019-08-23 08:14:52 (4880): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-23 08:14:52 (4880): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-23 08:14:52 (4880): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-23 08:14:52 (4880): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-23 08:15:11 (4880): Successfully started VM. (PID = '18636')
2019-08-23 08:15:11 (4880): Reporting VM Process ID to BOINC.
2019-08-23 08:15:17 (4880): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-23 08:15:22 (4880): Detected: Web Application Enabled (http://localhost:55228)
2019-08-23 08:15:22 (4880): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-23 08:15:28 (4880): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880176c26410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-23 08:15:28 (4880): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880176a80410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-23 08:15:28 (4880): Preference change detected
2019-08-23 08:15:28 (4880): Setting CPU throttle for VM. (50%)
2019-08-23 08:15:28 (4880): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-23 08:15:33 (4880): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880176a80410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-23 08:15:33 (4880): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880176a80210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-23 08:16:11 (4880): Guest Log: Copying input files into RunAtlas.

2019-08-23 08:16:19 (4880): Guest Log: Copied input files into RunAtlas.

2019-08-23 08:16:32 (4880): Guest Log: copied the webapp to /var/www

2019-08-23 08:16:32 (4880): Guest Log: This vm does not need to setup http proxy

2019-08-23 08:16:32 (4880): Guest Log: ATHENA_PROC_NUMBER=3

2019-08-23 08:16:32 (4880): Guest Log: Starting ATLAS job. (PandaID=4452885080 taskID=18722222)

2019-08-23 09:55:21 (4880): Status Report: Elapsed Time: '6004.397833'
2019-08-23 09:55:21 (4880): Status Report: CPU Time: '8239.812500'
2019-08-23 11:35:25 (4880): Status Report: Elapsed Time: '12007.435438'
2019-08-23 11:35:25 (4880): Status Report: CPU Time: '14685.171875'
2019-08-23 11:47:17 (4880): Stopping VM.
2019-08-23 11:48:03 (4880): Successfully stopped VM.
2019-08-23 12:04:07 (26392): vboxwrapper (7.9.26200): starting
2019-08-23 12:04:08 (26392): Feature: Checkpoint interval offset (378 seconds)
2019-08-23 12:04:08 (26392): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-23 12:04:08 (26392): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-23 12:04:09 (26392): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880176c26410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-23 12:04:09 (26392): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880176a80410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-23 12:04:09 (26392): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880176a80410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-23 12:04:09 (26392): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880176a80210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-23 12:04:09 (26392): Guest Log: Copying input files into RunAtlas.

2019-08-23 12:04:09 (26392): Guest Log: Copied input files into RunAtlas.

2019-08-23 12:04:09 (26392): Guest Log: copied the webapp to /var/www

2019-08-23 12:04:09 (26392): Guest Log: This vm does not need to setup http proxy

2019-08-23 12:04:09 (26392): Guest Log: ATHENA_PROC_NUMBER=3

2019-08-23 12:04:09 (26392): Guest Log: Starting ATLAS job. (PandaID=4452885080 taskID=18722222)

2019-08-23 12:04:09 (26392): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-23 12:04:49 (26392): Successfully started VM. (PID = '3596')
2019-08-23 12:04:49 (26392): Reporting VM Process ID to BOINC.
2019-08-23 12:05:01 (26392): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-23 12:05:11 (26392): Detected: Web Application Enabled (http://localhost:55228)
2019-08-23 12:05:11 (26392): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-23 12:05:22 (26392): Status Report: Elapsed Time: '12716.994307'
2019-08-23 12:05:22 (26392): Status Report: CPU Time: '15551.812500'
2019-08-23 12:05:22 (26392): Preference change detected
2019-08-23 12:05:22 (26392): Setting CPU throttle for VM. (50%)
2019-08-23 12:05:23 (26392): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-23 12:23:04 (26392): Stopping VM.
2019-08-23 12:23:48 (26392): Successfully stopped VM.
2019-08-24 14:56:06 (4120): vboxwrapper (7.9.26200): starting
2019-08-24 14:56:07 (4120): Feature: Checkpoint interval offset (247 seconds)
2019-08-24 14:56:07 (4120): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-24 14:56:07 (4120): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-24 14:56:08 (4120): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-24 14:58:11 (4120): Successfully started VM. (PID = '21348')
2019-08-24 14:58:11 (4120): Reporting VM Process ID to BOINC.
2019-08-24 14:58:18 (4120): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-24 14:58:24 (4120): Detected: Web Application Enabled (http://localhost:55228)
2019-08-24 14:58:24 (4120): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-24 14:58:30 (4120): Status Report: Elapsed Time: '13784.161879'
2019-08-24 14:58:30 (4120): Status Report: CPU Time: '16591.828125'
2019-08-24 14:58:30 (4120): Preference change detected
2019-08-24 14:58:30 (4120): Setting CPU throttle for VM. (20%)
2019-08-24 14:58:30 (4120): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-24 15:30:37 (4120): Stopping VM.
2019-08-24 15:31:09 (4120): Successfully stopped VM.
2019-08-25 16:58:42 (9092): vboxwrapper (7.9.26200): starting
2019-08-25 16:58:43 (9092): Feature: Checkpoint interval offset (544 seconds)
2019-08-25 16:58:43 (9092): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-25 16:58:44 (9092): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-25 16:58:44 (9092): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-25 16:59:27 (9092): Successfully started VM. (PID = '9180')
2019-08-25 16:59:27 (9092): Reporting VM Process ID to BOINC.
2019-08-25 16:59:34 (9092): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-25 16:59:39 (9092): Detected: Web Application Enabled (http://localhost:55228)
2019-08-25 16:59:39 (9092): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-25 16:59:45 (9092): Status Report: Elapsed Time: '15710.963547'
2019-08-25 16:59:45 (9092): Status Report: CPU Time: '18324.781250'
2019-08-25 16:59:45 (9092): Preference change detected
2019-08-25 16:59:45 (9092): Setting CPU throttle for VM. (50%)
2019-08-25 16:59:46 (9092): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-25 17:02:33 (9092): Stopping VM.
2019-08-25 17:03:05 (9092): Successfully stopped VM.
2019-08-25 19:12:03 (23376): vboxwrapper (7.9.26200): starting
2019-08-25 19:12:05 (23376): Feature: Checkpoint interval offset (198 seconds)
2019-08-25 19:12:05 (23376): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-25 19:12:05 (23376): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-25 19:12:05 (23376): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-25 19:12:45 (23376): Successfully started VM. (PID = '21068')
2019-08-25 19:12:45 (23376): Reporting VM Process ID to BOINC.
2019-08-25 19:12:52 (23376): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-25 19:12:57 (23376): Detected: Web Application Enabled (http://localhost:55228)
2019-08-25 19:12:57 (23376): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-25 19:13:03 (23376): Status Report: Elapsed Time: '15879.400103'
2019-08-25 19:13:03 (23376): Status Report: CPU Time: '18562.000000'
2019-08-25 19:13:03 (23376): Preference change detected
2019-08-25 19:13:03 (23376): Setting CPU throttle for VM. (50%)
2019-08-25 19:13:04 (23376): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-25 19:49:24 (23376): Stopping VM.
2019-08-25 19:49:57 (23376): Successfully stopped VM.
2019-08-26 18:16:37 (23424): vboxwrapper (7.9.26200): starting
2019-08-26 18:16:39 (23424): Feature: Checkpoint interval offset (201 seconds)
2019-08-26 18:16:39 (23424): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-26 18:16:39 (23424): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-26 18:16:40 (23424): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-26 18:18:33 (23424): Successfully started VM. (PID = '23400')
2019-08-26 18:18:33 (23424): Reporting VM Process ID to BOINC.
2019-08-26 18:18:40 (23424): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-26 18:18:46 (23424): Detected: Web Application Enabled (http://localhost:55228)
2019-08-26 18:18:46 (23424): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-26 18:18:52 (23424): Status Report: Elapsed Time: '18059.654826'
2019-08-26 18:18:52 (23424): Status Report: CPU Time: '22248.140625'
2019-08-26 18:18:52 (23424): Preference change detected
2019-08-26 18:18:52 (23424): Setting CPU throttle for VM. (50%)
2019-08-26 18:18:52 (23424): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-26 18:40:23 (23424): Stopping VM.
2019-08-26 18:41:01 (23424): Successfully stopped VM.
2019-08-26 19:03:59 (22372): vboxwrapper (7.9.26200): starting
2019-08-26 19:04:00 (22372): Feature: Checkpoint interval offset (138 seconds)
2019-08-26 19:04:00 (22372): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-26 19:04:00 (22372): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-26 19:04:01 (22372): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-26 19:06:05 (22372): Successfully started VM. (PID = '6904')
2019-08-26 19:06:05 (22372): Reporting VM Process ID to BOINC.
2019-08-26 19:06:11 (22372): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-26 19:06:17 (22372): Detected: Web Application Enabled (http://localhost:55228)
2019-08-26 19:06:17 (22372): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-26 19:06:23 (22372): Status Report: Elapsed Time: '19350.967940'
2019-08-26 19:06:23 (22372): Status Report: CPU Time: '24465.093750'
2019-08-26 19:06:23 (22372): Preference change detected
2019-08-26 19:06:23 (22372): Setting CPU throttle for VM. (50%)
2019-08-26 19:06:24 (22372): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-26 19:53:26 (22372): Stopping VM.
2019-08-26 19:54:11 (22372): Successfully stopped VM.
2019-08-26 19:56:36 (20540): vboxwrapper (7.9.26200): starting
2019-08-26 19:56:37 (20540): Feature: Checkpoint interval offset (28 seconds)
2019-08-26 19:56:37 (20540): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-26 19:56:38 (20540): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-26 19:56:38 (20540): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-26 19:57:09 (20540): Successfully started VM. (PID = '13020')
2019-08-26 19:57:09 (20540): Reporting VM Process ID to BOINC.
2019-08-26 19:57:15 (20540): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-26 19:57:21 (20540): Detected: Web Application Enabled (http://localhost:55228)
2019-08-26 19:57:21 (20540): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-26 19:57:27 (20540): Status Report: Elapsed Time: '22172.455767'
2019-08-26 19:57:27 (20540): Status Report: CPU Time: '28868.250000'
2019-08-26 19:57:27 (20540): Preference change detected
2019-08-26 19:57:27 (20540): Setting CPU throttle for VM. (50%)
2019-08-26 19:57:27 (20540): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-26 20:06:46 (20540): Stopping VM.
2019-08-26 20:07:29 (20540): Successfully stopped VM.
2019-08-26 20:30:46 (13020): vboxwrapper (7.9.26200): starting
2019-08-26 20:30:47 (13020): Feature: Checkpoint interval offset (179 seconds)
2019-08-26 20:30:47 (13020): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-26 20:30:48 (13020): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-26 20:30:48 (13020): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-26 20:31:35 (13020): Successfully started VM. (PID = '23220')
2019-08-26 20:31:35 (13020): Reporting VM Process ID to BOINC.
2019-08-26 20:31:41 (13020): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-26 20:31:47 (13020): Detected: Web Application Enabled (http://localhost:55228)
2019-08-26 20:31:47 (13020): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-26 20:31:53 (13020): Status Report: Elapsed Time: '22731.396340'
2019-08-26 20:31:53 (13020): Status Report: CPU Time: '29849.203125'
2019-08-26 20:31:53 (13020): Preference change detected
2019-08-26 20:31:53 (13020): Setting CPU throttle for VM. (50%)
2019-08-26 20:31:54 (13020): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-26 20:38:41 (13020): Stopping VM.
2019-08-26 20:39:32 (13020): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_8d1e3a970dcf8c39" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...
2019-08-26 20:39:32 (13020): VM did not stop when requested.
2019-08-26 20:39:32 (13020): VM was successfully terminated.
2019-08-26 20:42:00 (23496): vboxwrapper (7.9.26200): starting
2019-08-26 20:42:00 (23496): Feature: Checkpoint interval offset (205 seconds)
2019-08-26 20:42:00 (23496): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-26 20:42:00 (23496): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-26 20:42:01 (23496): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-26 20:42:06 (23496): Successfully started VM. (PID = '3384')
2019-08-26 20:42:06 (23496): Reporting VM Process ID to BOINC.
2019-08-26 20:42:11 (23496): Guest Log: BIOS: VirtualBox 6.0.10

2019-08-26 20:42:11 (23496): Guest Log: CPUID EDX: 0x178bfbfd

2019-08-26 20:42:11 (23496): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-26 20:42:11 (23496): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-26 20:42:11 (23496): Guest Log: BIOS: Booting from Hard Disk...

2019-08-26 20:42:11 (23496): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-26 20:42:11 (23496): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-26 20:42:11 (23496): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-26 20:42:16 (23496): Detected: Web Application Enabled (http://localhost:55228)
2019-08-26 20:42:16 (23496): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-26 20:42:22 (23496): Status Report: Elapsed Time: '23139.044116'
2019-08-26 20:42:22 (23496): Status Report: CPU Time: '30514.031250'
2019-08-26 20:42:22 (23496): Preference change detected
2019-08-26 20:42:22 (23496): Setting CPU throttle for VM. (50%)
2019-08-26 20:42:22 (23496): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-26 20:42:39 (23496): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-26 20:42:51 (23496): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880177063410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-26 20:42:51 (23496): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880177063810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-26 20:42:57 (23496): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880177648a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-26 20:42:57 (23496): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880177648a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-26 20:44:23 (23496): Stopping VM.
2019-08-26 20:44:27 (23496): Successfully stopped VM.
2019-08-26 20:48:06 (24476): vboxwrapper (7.9.26200): starting
2019-08-26 20:48:06 (24476): Feature: Checkpoint interval offset (264 seconds)
2019-08-26 20:48:06 (24476): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-26 20:48:06 (24476): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-26 20:48:07 (24476): Guest Log: BIOS: VirtualBox 6.0.10

2019-08-26 20:48:07 (24476): Guest Log: CPUID EDX: 0x178bfbfd

2019-08-26 20:48:07 (24476): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-26 20:48:07 (24476): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-26 20:48:07 (24476): Guest Log: BIOS: Booting from Hard Disk...

2019-08-26 20:48:07 (24476): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-26 20:48:07 (24476): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-26 20:48:07 (24476): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-26 20:48:07 (24476): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880177063410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-26 20:48:07 (24476): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880177063810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-26 20:48:07 (24476): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880177648a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-26 20:48:07 (24476): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880177648a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-26 20:48:07 (24476): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-26 20:48:23 (24476): Successfully started VM. (PID = '6276')
2019-08-26 20:48:23 (24476): Reporting VM Process ID to BOINC.
2019-08-26 20:48:29 (24476): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-26 20:48:35 (24476): Detected: Web Application Enabled (http://localhost:55228)
2019-08-26 20:48:35 (24476): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-26 20:48:41 (24476): Stopping VM.
2019-08-26 20:48:45 (24476): Successfully stopped VM.
2019-08-26 20:51:57 (17480): vboxwrapper (7.9.26200): starting
2019-08-26 20:51:58 (17480): Feature: Checkpoint interval offset (445 seconds)
2019-08-26 20:51:58 (17480): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-26 20:51:58 (17480): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-26 20:51:59 (17480): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-26 20:52:13 (17480): Successfully started VM. (PID = '23468')
2019-08-26 20:52:13 (17480): Reporting VM Process ID to BOINC.
2019-08-26 20:52:19 (17480): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-26 20:52:24 (17480): Detected: Web Application Enabled (http://localhost:55228)
2019-08-26 20:52:24 (17480): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-26 20:52:30 (17480): Status Report: Elapsed Time: '23259.761962'
2019-08-26 20:52:30 (17480): Status Report: CPU Time: '30551.984375'
2019-08-26 20:52:30 (17480): Preference change detected
2019-08-26 20:52:30 (17480): Setting CPU throttle for VM. (50%)
2019-08-26 20:52:30 (17480): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-26 20:52:42 (17480): Guest Log: Copying input files into RunAtlas.

2019-08-26 20:52:48 (17480): Guest Log: Copied input files into RunAtlas.

2019-08-26 20:52:48 (17480): Guest Log: copied the webapp to /var/www

2019-08-26 20:52:48 (17480): Guest Log: This vm does not need to setup http proxy

2019-08-26 20:52:48 (17480): Guest Log: ATHENA_PROC_NUMBER=3

2019-08-26 20:52:48 (17480): Guest Log: Starting ATLAS job. (PandaID=4452885080 taskID=18722222)

2019-08-26 21:05:33 (17480): Stopping VM.
2019-08-26 21:06:19 (17480): Successfully stopped VM.
2019-08-26 21:14:09 (3300): vboxwrapper (7.9.26200): starting
2019-08-26 21:14:11 (3300): Feature: Checkpoint interval offset (198 seconds)
2019-08-26 21:14:11 (3300): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-26 21:14:11 (3300): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-26 21:14:11 (3300): Guest Log: Copying input files into RunAtlas.

2019-08-26 21:14:11 (3300): Guest Log: Copied input files into RunAtlas.

2019-08-26 21:14:11 (3300): Guest Log: copied the webapp to /var/www

2019-08-26 21:14:11 (3300): Guest Log: This vm does not need to setup http proxy

2019-08-26 21:14:11 (3300): Guest Log: ATHENA_PROC_NUMBER=3

2019-08-26 21:14:11 (3300): Guest Log: Starting ATLAS job. (PandaID=4452885080 taskID=18722222)

2019-08-26 21:14:11 (3300): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-26 21:14:37 (3300): Successfully started VM. (PID = '17892')
2019-08-26 21:14:37 (3300): Reporting VM Process ID to BOINC.
2019-08-26 21:14:43 (3300): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-26 21:14:49 (3300): Detected: Web Application Enabled (http://localhost:55228)
2019-08-26 21:14:49 (3300): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-26 21:14:55 (3300): Status Report: Elapsed Time: '24043.074317'
2019-08-26 21:14:55 (3300): Status Report: CPU Time: '31127.843750'
2019-08-26 21:14:55 (3300): Preference change detected
2019-08-26 21:14:55 (3300): Setting CPU throttle for VM. (50%)
2019-08-26 21:14:55 (3300): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-26 21:16:08 (3300): Stopping VM.
2019-08-26 21:16:08 (3300): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_8d1e3a970dcf8c39" savestate
Output:

2019-08-26 21:16:08 (3300): VM did not stop when requested.
2019-08-26 21:16:08 (3300): VM was NOT successfully terminated.
2019-08-27 18:05:18 (14776): vboxwrapper (7.9.26200): starting
2019-08-27 18:05:19 (14776): Feature: Checkpoint interval offset (284 seconds)
2019-08-27 18:05:19 (14776): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-08-27 18:05:19 (14776): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-27 18:05:20 (14776): Starting VM using VboxManage interface. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-27 18:05:25 (14776): Successfully started VM. (PID = '19504')
2019-08-27 18:05:25 (14776): Reporting VM Process ID to BOINC.
2019-08-27 18:05:31 (14776): Guest Log: BIOS: VirtualBox 6.0.10

2019-08-27 18:05:31 (14776): Guest Log: CPUID EDX: 0x178bfbfd

2019-08-27 18:05:31 (14776): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-27 18:05:31 (14776): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-27 18:05:31 (14776): Guest Log: BIOS: Booting from Hard Disk...

2019-08-27 18:05:31 (14776): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-27 18:05:31 (14776): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-27 18:05:31 (14776): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-27 18:05:37 (14776): Detected: Web Application Enabled (http://localhost:55228)
2019-08-27 18:05:37 (14776): Detected: Remote Desktop Enabled (localhost:55229)
2019-08-27 18:05:43 (14776): Status Report: Elapsed Time: '24117.056390'
2019-08-27 18:05:43 (14776): Status Report: CPU Time: '31276.000000'
2019-08-27 18:05:43 (14776): Preference change detected
2019-08-27 18:05:43 (14776): Setting CPU throttle for VM. (50%)
2019-08-27 18:05:43 (14776): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-27 18:06:01 (14776): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-27 18:06:19 (14776): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880177656810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-27 18:06:19 (14776): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880174955810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-27 18:06:19 (14776): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880174954a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-27 18:06:19 (14776): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880174e77010), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-27 18:16:34 (14776): Guest Log: CCCoopopypyiyininng g i ininpnpuptuttf ffiillsees s i inintntoto o R uRnuAnAtAltalsa.s.

2019-08-27 18:16:34 (14776): Guest Log: CCCoopopypyiyininng g i ininpnpuptuttf ffiillsees s i inintntoto o R uRnuAnAtAltalsa.s..

2019-08-27 18:16:34 (14776): Guest Log: CCCoopopypyiyininng g i ininpnpuptuttf ffiillsees s i inintntoto o R uRnuAnAtAltalsa.s..

2019-08-27 18:16:34 (14776): Guest Log: Copying input files into RunAtlas.

2019-08-27 18:16:34 (14776): Guest Log: Copying input files intCo RoupnyAitnlga si.np

2019-08-27 18:16:34 (14776): Guest Log: les into RunAtlas.

2019-08-27 18:16:34 (14776): Guest Log: Copying input files into RunAtlas.

2019-08-27 18:16:34 (14776): Guest Log: Copied input files into RunAtlas.

2019-08-27 18:16:40 (14776): Guest Log: copied the webapp to /var/www

2019-08-27 18:16:40 (14776): Guest Log: This vm does not need to setup http proxy

2019-08-27 18:16:40 (14776): Guest Log: ATHENA_PROC_NUMBER=3

2019-08-27 18:16:46 (14776): Guest Log: Starting ATLAS job. (PandaID=4452885080 taskID=18722222)

2019-08-27 18:16:58 (14776): Guest Log: Copied inpCuto pifeidleisn piuntt of Riulnes Aitlnatso. 

2019-08-27 18:16:58 (14776): Guest Log: as.

2019-08-27 18:16:58 (14776): Guest Log: Copied input files into RunAtlas.

2019-08-27 18:16:58 (14776): Guest Log: Copied input files into RunAtlas.

2019-08-27 18:16:58 (14776): Guest Log: Copied input files into RunAtlas.

2019-08-27 18:16:58 (14776): Guest Log: Copied input files into RunAtlas.

2019-08-27 18:17:05 (14776): Guest Log: copied the webapp to /var/www

2019-08-27 18:17:05 (14776): Guest Log: copied the webapp to /var/www

2019-08-27 18:17:05 (14776): Guest Log: copied the webapp to /var/www

2019-08-27 18:17:05 (14776): Guest Log: copied the webapp to /var/www

2019-08-27 18:17:05 (14776): Guest Log: copied the webapp to /var/www

2019-08-27 18:17:05 (14776): Guest Log: copied the webapp to /var/www

2019-08-27 18:17:05 (14776): Guest Log: This vm does not need to setup http proxy

2019-08-27 18:17:05 (14776): Guest Log: This vm does not need to setup http proxy

2019-08-27 18:17:05 (14776): Guest Log: This vm does not need to setup http proxy

2019-08-27 18:17:05 (14776): Guest Log: ATHENA_PROC_NUMBER=3

2019-08-27 18:17:05 (14776): Guest Log: This vm does not need to setup http proxy

2019-08-27 18:17:05 (14776): Guest Log: ATHENA_PROC_NUMBER=3

2019-08-27 18:17:05 (14776): Guest Log: ATHENA_PROC_NUMBER=3

2019-08-27 18:17:05 (14776): Guest Log: ATThHiEs NvAm_ PdRoOesC _nNotU MnBeER=3

2019-08-27 18:17:05 (14776): Guest Log: ed to setup http proxy

2019-08-27 18:17:05 (14776): Guest Log: This vm does not need to setup http proxy

2019-08-27 18:17:05 (14776): Guest Log: ATHENA_PROC_NUMBER=3

2019-08-27 18:17:05 (14776): Guest Log: ATHENA_PROC_NUMBER=3

2019-08-27 18:17:05 (14776): Guest Log: Starting ATLAS job. (PandaID=4452885080 taskID=18722222)

2019-08-27 18:17:05 (14776): Guest Log: Starting ATLAS job. (PandaID=4452885080 taskID=18722222)

2019-08-27 18:17:05 (14776): Guest Log: Starting ATLAS job. (PandaID=4452885080 taskID=18722222)

2019-08-27 18:17:05 (14776): Guest Log: Starting ATLAS job. (PandaID=4452885080 taskID=18722222)

2019-08-27 18:17:05 (14776): Guest Log: Starting ATLAS job. (PandaID=4452885080 taskID=18722222)

2019-08-27 18:17:05 (14776): Guest Log: Starting ATLAS job. (PandaID=4452885080 taskID=18722222)

2019-08-27 18:20:39 (14776): Guest Log: The last 10 lines of the pilot log.

2019-08-27 18:20:39 (14776): Guest Log: pilot.py

2019-08-27 18:20:39 (14776): Guest Log: -rw-------  1 atlas01 atlas01     9 Aug 19 15:00 PILOTVERSION

2019-08-27 18:20:39 (14776): Guest Log: -rw-------  1 atlas01 atlas01  2251 Jul 25 17:38 README.md

2019-08-27 18:20:39 (14776): Guest Log: -rw-------  1 atlas01 atlas01   221 Jul 25 17:38 TODO.md

2019-08-27 18:20:39 (14776): Guest Log: 2019-08-27 15:20:34 UTC [wrapper] Test setup, not cleaning

2019-08-27 18:20:39 (14776): Guest Log: 2019-08-27 15:20:34 UTC [wrapper] ==== wrapper stdout END ====

2019-08-27 18:20:39 (14776): Guest Log: 2019-08-27 15:20:34 UTC [wrapper] ==== wrapper stderr END ====

2019-08-27 18:20:39 (14776): Guest Log: 2019-08-27 15:20:34 UTC [wrapper] wrapper wrapperexiting ec=0, duration=210

2019-08-27 18:20:39 (14776): Guest Log: 2019-08-27 15:20:34 UTC [wrapper] apfmon messages muted

2019-08-27 18:20:39 (14776): Guest Log: Listing of results directory

2019-08-27 18:20:39 (14776): Guest Log: total 12464

2019-08-27 18:20:39 (14776): Guest Log: drwx------ 3 atlas01 atlas01    4096 Aug 19 15:00 pilot2

2019-08-27 18:20:39 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01  255033 Aug 19 18:37 pilot2.tar.gz

2019-08-27 18:20:39 (14776): Guest Log: -rwx------ 1 atlas01 atlas01   12641 Aug 19 19:26 runpilot2-wrapper.sh

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01    2921 Aug 19 19:26 pandaJobData.out

2019-08-27 18:20:39 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01    4468 Aug 19 19:26 queuedata.json

2019-08-27 18:20:39 (14776): Guest Log: drwxr-xr-x 3 atlas01 atlas01    4096 Aug 27 18:16 APPS

2019-08-27 18:20:39 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01    8683 Aug 27 18:16 init_data.xml

2019-08-27 18:20:39 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01  263678 Aug 27 18:16 input.tar.gz

2019-08-27 18:20:39 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01     815 Aug 27 18:16 RTE.tar.gz

2019-08-27 18:20:39 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01    8659 Aug 27 18:16 start_atlas.sh

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01 4336863 Aug 27 18:18 agis_schedconf.cvmfs.json

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01 7461913 Aug 27 18:18 agis_ddmendpoints.json

2019-08-27 18:20:39 (14776): Guest Log: drwxrwx--- 2 atlas01 atlas01    4096 Aug 27 18:20 PanDA_Pilot-4452885080

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01    1662 Aug 27 18:20 heartbeat.json

2019-08-27 18:20:39 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01     643 Aug 27 18:20 runtime_log

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01  184320 Aug 27 18:20 result.tar.gz

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01   68105 Aug 27 18:20 pilotlog.txt

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01   85247 Aug 27 18:20 log.18722222._018891.job.log.1

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01     784 Aug 27 18:20 VY2LDmYfzJvnShfckohDCDFpABFKDmABFKDmK2PMDmABFKDmy1sNHn.diag

2019-08-27 18:20:39 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01    6155 Aug 27 18:20 runtime_log.err

2019-08-27 18:20:39 (14776): Guest Log: The last 10 lines of the pilot log.

2019-08-27 18:20:39 (14776): Guest Log: No HITS file was produced

2019-08-27 18:20:39 (14776): Guest Log: ---- find pandaID.out ----

2019-08-27 18:20:39 (14776): Guest Log: total 52

2019-08-27 18:20:39 (14776): Guest Log: -rw-------  1 atlas01 atlas01 11357 Jul 25 17:38 LICENSE

2019-08-27 18:20:39 (14776): Guest Log: drwx------ 14 2019-08-27 15:20:35 UTC [wrapper] Pilot exit status: 66

2019-08-27 18:20:39 (14776): Guest Log: tlas01 atlas01 20628 Aug 19 15:00 pilot.py

2019-08-27 18:20:39 (14776): Guest Log: -rw-------  1 atlas01 atlas01     9 Aug 19 15:00 PILOTVERSION

2019-08-27 18:20:39 (14776): Guest Log: -rw-------  1 atlas01 atlas01  2251 Jul 25 17:38 README.md

2019-08-27 18:20:39 (14776): Guest Log: -rw-------  1 atlas01 atlas01   221 Jul 25 17:38 TODO.md

2019-08-27 18:20:39 (14776): Guest Log: r] wrapper wrapperexiting ec=0, duration=210

2019-08-27 18:20:39 (14776): Guest Log: 2019-08-27 15:20:34 UTC [wrapper] apfmon messages muted

2019-08-27 18:20:39 (14776): Guest Log: Successfully finished the ATLAS job!

2019-08-27 18:20:39 (14776): Guest Log: Listing of results directory

2019-08-27 18:20:39 (14776): Guest Log: Copying the results back to the shared directory!

2019-08-27 18:20:39 (14776): Guest Log: total 12464

2019-08-27 18:20:39 (14776): Guest Log: drwx------ 3 atlas01 atlas01    4096 Aug 19 15:00 pilot2

2019-08-27 18:20:39 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01  255033 Aug 19 18:37 pilot2.tar.gz

2019-08-27 18:20:39 (14776): Guest Log: -rwx------ 1 atlas01 atlas01   12641 Aug 19 19:26 runpilot2-wrapper.sh

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01    2921 Aug 19 19:26 pandaJobData.out

2019-08-27 18:20:39 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01    4468 Aug 19 19:26 queuedata.json

2019-08-27 18:20:39 (14776): Guest Log: drwxr-xr-x 3 atlas01 atlas01    4096 Aug 27 18:16 APPS

2019-08-27 18:20:39 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01    8683 Aug 27 18:16 init_data.xml

2019-08-27 18:20:39 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01  263678 Aug 27 18:16 input.tar.gz

2019-08-27 18:20:39 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01     815 Aug 27 18:16 RTE.tar.gz

2019-08-27 18:20:39 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01    8659 Aug 27 18:16 start_atlas.sh

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01 4336863 Aug 27 18:18 agis_schedconf.cvmfs.json

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01 7461913 Aug 27 18:18 agis_ddmendpoints.json

2019-08-27 18:20:39 (14776): Guest Log: drwxrwx--- 2 atlas01 atlas01    4096 Aug 27 18:20 PanDA_Pilot-4452885080

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01    1662 Aug 27 18:20 heartbeat.json

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01     829 Aug 27 18:20 VY2LDmYfzJvnShfckohDCDFpABFKDmABFKDmK2PMDmABFKDmy1sNHn.diag

2019-08-27 18:20:39 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01    6205 Aug 27 18:20 runtime_log.err

2019-08-27 18:20:39 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01     643 Aug 27 18:20 runtime_log

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01  184320 Aug 27 18:20 result.tar.gz

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01   68105 Aug 27 18:20 pilotlog.txt

2019-08-27 18:20:39 (14776): Guest Log: -rw------- 1 atlas01 atlas01   85600 Aug 27 18:20 log.18722222._018891.job.log.1

2019-08-27 18:20:40 (14776): Guest Log: No HITS file was produced

2019-08-27 18:20:40 (14776): Guest Log: The last 10 lines of the pilot log.

2019-08-27 18:20:40 (14776): Guest Log: Successfully finished the ATLAS job!

2019-08-27 18:20:40 (14776): Guest Log: The last 10 lines of the pilot log.

2019-08-27 18:20:40 (14776): Guest Log: drwx------ 14 atlas01 atlas01  4096 Aug 27 18:18 pilot

2019-08-27 18:20:40 (14776): Guest Log: -rwx------  1 atlas01 atlas02019-08-27 15:20:35 UTC [wrapper] ==== wrapper stdout END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] ==== wrapper stderr END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] wrapper wrapperexiting ec=0, duration=210

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] apfmon messages muted

2019-08-27 18:20:40 (14776): Guest Log:  cleaning

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] ==== wrapper stdout END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] ==== wrapper stderr END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:36 UTC [wrapper] wrapper wrapperexiting ec=0, duration=211

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:36 UTC [wrapper] apfmon messages muted

2019-08-27 18:20:40 (14776): Guest Log: Copying the results back to the shared directory!

2019-08-27 18:20:40 (14776): Guest Log: drwx------ 14 atlas01 atlas01  4096 Aug 27 18:18 pilot

2019-08-27 18:20:40 (14776): Guest Log: -rwx------  1 atlas01 atlas02019-08-27 15:20:35 UTC [wrapper] ==== wrapper stdout END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] ==== wrapper stderr END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] wrapper wrapperexiting ec=0, duration=210

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] apfmon messages muted

2019-08-27 18:20:40 (14776): Guest Log:  cleaning

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] ==== wrapper stdout END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] ==== wrapper stderr END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:36 UTC [wrapper] wrapper wrapperexiting ec=0, duration=211

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:36 UTC [wrapper] apfmon messages muted

2019-08-27 18:20:40 (14776): Guest Log: Listing of results directory

2019-08-27 18:20:40 (14776): Guest Log: Listing of results directory

2019-08-27 18:20:40 (14776): Guest Log: Copied the result file back to the shared directortotal 1246y4 

2019-08-27 18:20:40 (14776): Guest Log: eatedd artwlxa-s-_-d-o-n-e  3f ialtel!a

2019-08-27 18:20:40 (14776): Guest Log: tlas01    4096 Aug 19 15:00 pilot2

2019-08-27 18:20:40 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01  255033 Aug 19 18:37 pilot2.tar.gz

2019-08-27 18:20:40 (14776): Guest Log: -rwx------ 1 atlas01 atlas01   12641 Aug 19 19:26 runpilot2-wrapper.sh

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01    2921 Aug 19 19:26 pandaJobData.out

2019-08-27 18:20:40 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01    4468 Aug 19 19:26 queuedata.json

2019-08-27 18:20:40 (14776): Guest Log: drwxr-xr-x 3 atlas01 atlas01    4096 Aug 27 18:16 APPS

2019-08-27 18:20:40 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01    8683 Aug 27 18:16 init_data.xml

2019-08-27 18:20:40 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01  263678 Aug 27 18:16 input.tar.gz

2019-08-27 18:20:40 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01     815 Aug 27 18:16 RTE.tar.gz

2019-08-27 18:20:40 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01    8659 Aug 27 18:16 start_atlas.sh

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01 4336863 Aug 27 18:18 agis_schedconf.cvmfs.json

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01 7461913 Aug 27 18:18 agis_ddmendpoints.json

2019-08-27 18:20:40 (14776): Guest Log: drwxrwx--- 2 atlas01 atlas01    4096 Aug 27 18:20 PanDA_Pilot-4452885080

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01    1662 Aug 27 18:20 heartbeat.json

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01  184320 Aug 27 18:20 result.tar.gz

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01     862 Aug 27 18:20 VY2LDmYfzJvnShfckohDCDFpABFKDmABFKDmK2PMDmABFKDmy1sNHn.diag

2019-08-27 18:20:40 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01    6205 Aug 27 18:20 runtime_log.err

2019-08-27 18:20:40 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01     643 Aug 27 18:20 runtime_log

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01   68105 Aug 27 18:20 pilotlog.txt

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01   85732 Aug 27 18:20 log.18722222._018891.job.log.1

2019-08-27 18:20:40 (14776): Guest Log: The last 10 lines of the pilot log.

2019-08-27 18:20:40 (14776): Guest Log: total 12464

2019-08-27 18:20:40 (14776): Guest Log: drwx------ 3 atlas01 atlas01    4096 Aug 19 15:00 pilot2

2019-08-27 18:20:40 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01  255033 Aug 19 18:37 pilot2.tar.gz

2019-08-27 18:20:40 (14776): Guest Log: -rwx------ 1 atlas01 atlas01   12641 Aug 19 19:26 runpilot2-wrapper.sh

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01    2921 Aug 19 19:26 pandaJobData.out

2019-08-27 18:20:40 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01    4468 Aug 19 19:26 queuedata.json

2019-08-27 18:20:40 (14776): Guest Log: drwxr-xr-x 3 atlas01 atlas01    4096 Aug 27 18:16 APPS

2019-08-27 18:20:40 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01    8683 Aug 27 18:16 init_data.xml

2019-08-27 18:20:40 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01  263678 Aug 27 18:16 input.tar.gz

2019-08-27 18:20:40 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01     815 Aug 27 18:16 RTE.tar.gz

2019-08-27 18:20:40 (14776): Guest Log: -rwxr-xr-x 1 atlas01 atlas01    8659 Aug 27 18:16 start_atlas.sh

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01 4336863 Aug 27 18:18 agis_schedconf.cvmfs.json

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01 7461913 Aug 27 18:18 agis_ddmendpoints.json

2019-08-27 18:20:40 (14776): Guest Log: drwxrwx--- 2 atlas01 atlas01    4096 Aug 27 18:20 PanDA_Pilot-4452885080

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01    1662 Aug 27 18:20 heartbeat.json

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01  184320 Aug 27 18:20 result.tar.gz

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01     862 Aug 27 18:20 VY2LDmYfzJvnShfckohDCDFpABFKDmABFKDmK2PMDmABFKDmy1sNHn.diag

2019-08-27 18:20:40 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01    6205 Aug 27 18:20 runtime_log.err

2019-08-27 18:20:40 (14776): Guest Log: -rw-r--r-- 1 atlas01 atlas01     643 Aug 27 18:20 runtime_log

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01   68105 Aug 27 18:20 pilotlog.txt

2019-08-27 18:20:40 (14776): Guest Log: -rw------- 1 atlas01 atlas01   85732 Aug 27 18:20 log.18722222._018891.job.log.1

2019-08-27 18:20:40 (14776): Guest Log: Success! Shutting down the machine.

2019-08-27 18:20:40 (14776): Guest Log: drwx------ 14 atlas01 atlas01  4096 Aug 27 18:18 pilot

2019-08-27 18:20:40 (14776): Guest Log: -rwx------  1 atlas01 atlas02019-08-27 15:20:35 UTC [wrapper] ==== wrapper stdout END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] ==== wrapper stderr END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] wrapper wrapperexiting ec=0, duration=210

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] apfmon messages muted

2019-08-27 18:20:40 (14776): Guest Log:  cleaning

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] ==== wrapper stdout END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:35 UTC [wrapper] ==== wrapper stderr END ====

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:36 UTC [wrapper] wrapper wrapperexiting ec=0, duration=211

2019-08-27 18:20:40 (14776): Guest Log: 2019-08-27 15:20:36 UTC [wrapper] apfmon messages muted

2019-08-27 18:20:40 (14776): Guest Log: No HITS file was produced

2019-08-27 18:20:40 (14776): Guest Log: No HITS file was produced

2019-08-27 18:20:40 (14776): Guest Log: Successfully finished the ATLAS job!

2019-08-27 18:20:40 (14776): Guest Log: Listing of results directory

2019-08-27 18:20:40 (14776): Guest Log: Successfully finished the ATLAS job!

2019-08-27 18:20:40 (14776): Guest Log: Copying the results back to the shared directory!

2019-08-27 18:20:40 (14776): Guest Log: total 12

2019-08-27 18:20:40 (14776): Guest Log: drwx------ 3 atlas01 atlas01 4096 Aug 19 15:00 pilot2

2019-08-27 18:20:40 (14776): Guest Log: drwxr-xr-x 3 atlas01 atlas01 4096 Aug 27 18:16 APPS

2019-08-27 18:20:40 (14776): Guest Log: drwxrwx--- 2 atlas01 atlas01 4096 Aug 27 18:20 PanDA_Pilot-4452885080

2019-08-27 18:20:40 (14776): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-08-27 18:20:40 (14776): Guest Log: Copying the results back to the shared directory!

2019-08-27 18:20:40 (14776): Guest Log: Success! Shutting down the machine.

2019-08-27 18:20:40 (14776): Guest Log: No HITS file was produced

2019-08-27 18:20:40 (14776): Guest Log: Successfully finished the ATLAS job!

2019-08-27 18:20:40 (14776): Guest Log: Copying the results back to the shared directory!

2019-08-27 18:20:40 (14776): Guest Log: Copied the rTeshult lfaislte  1b0a clki nteos  otfh et hseh aprieldo td ilroegc.to

2019-08-27 18:20:40 (14776): Guest Log:  created atlas_done file!

2019-08-27 18:20:40 (14776): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-08-27 18:20:40 (14776): Guest Log: Success! Shutting down the machine.

2019-08-27 18:20:40 (14776): Guest Log: Success! Shutting down the machine.

2019-08-27 18:20:40 (14776): Guest Log: Listing of results directory

2019-08-27 18:20:40 (14776): Guest Log: total 12

2019-08-27 18:20:40 (14776): Guest Log: drwx------ 3 atlas01 atlas01 4096 Aug 19 15:00 pilot2

2019-08-27 18:20:40 (14776): Guest Log: drwxr-xr-x 3 atlas01 atlas01 4096 Aug 27 18:16 APPS

2019-08-27 18:20:40 (14776): Guest Log: drwxrwx--- 2 atlas01 atlas01 4096 Aug 27 18:20 PanDA_Pilot-4452885080

2019-08-27 18:20:40 (14776): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-08-27 18:20:40 (14776): Guest Log: No HITS file was produced

2019-08-27 18:20:40 (14776): Guest Log: Success! Shutting down the machine.

2019-08-27 18:20:40 (14776): Guest Log: Successfully finished the ATLAS job!

2019-08-27 18:20:40 (14776): Guest Log: Copying the results back to the shared directory!

2019-08-27 18:20:40 (14776): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-08-27 18:20:40 (14776): VM Completion File Detected.
2019-08-27 18:20:40 (14776): Powering off VM.
2019-08-27 18:20:41 (14776): Guest Log: Success! Shutting down the machine.

2019-08-27 18:20:41 (14776): Successfully stopped VM.
2019-08-27 18:20:41 (14776): Deregistering VM. (boinc_8d1e3a970dcf8c39, slot#5)
2019-08-27 18:20:41 (14776): Removing network bandwidth throttle group from VM.
2019-08-27 18:20:41 (14776): Removing VM from VirtualBox.
18:20:47 (14776): called boinc_finish(0)

</stderr_txt>
]]>
Development for LHC@home

Stderr output
