Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-07-10 05:48:03 (1096): vboxwrapper (7.9.26200): starting
2019-07-10 05:48:03 (1096): Feature: Checkpoint interval offset (66 seconds)
2019-07-10 05:48:03 (1096): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-10 05:48:03 (1096): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-10 05:48:03 (1096): Successfully copied 'init_data.xml' to the shared directory.
2019-07-10 05:48:03 (1096): Create VM. (boinc_7b6bf2c1f45cc157, slot#4)
2019-07-10 05:48:03 (1096): Setting Memory Size for VM. (6600MB)
2019-07-10 05:48:03 (1096): Setting CPU Count for VM. (4)
2019-07-10 05:48:03 (1096): Setting Chipset Options for VM.
2019-07-10 05:48:03 (1096): Setting Boot Options for VM.
2019-07-10 05:48:03 (1096): Enabling VM Network Access.
2019-07-10 05:48:03 (1096): Setting Network Configuration for NAT.
2019-07-10 05:48:03 (1096): Disabling USB Support for VM.
2019-07-10 05:48:03 (1096): Disabling COM Port Support for VM.
2019-07-10 05:48:03 (1096): Disabling LPT Port Support for VM.
2019-07-10 05:48:03 (1096): Disabling Audio Support for VM.
2019-07-10 05:48:03 (1096): Disabling Clipboard Support for VM.
2019-07-10 05:48:03 (1096): Disabling Drag and Drop Support for VM.
2019-07-10 05:48:03 (1096): Adding storage controller(s) to VM.
2019-07-10 05:48:03 (1096): Adding virtual disk drive to VM. (vm_image.vdi)
2019-07-10 05:48:03 (1096): Adding VirtualBox Guest Additions to VM.
2019-07-10 05:48:03 (1096): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-07-10 05:48:03 (1096): forwarding host port 60421 to guest port 80
2019-07-10 05:48:03 (1096): Enabling remote desktop for VM.
2019-07-10 05:48:03 (1096): Required extension pack not installed, remote desktop not enabled.
2019-07-10 05:48:03 (1096): Enabling shared directory for VM.
2019-07-10 05:48:03 (1096): Starting VM. (boinc_7b6bf2c1f45cc157, slot#4)
2019-07-10 05:48:11 (1096): Guest Log: BIOS: VirtualBox 5.2.8

2019-07-10 05:48:11 (1096): Guest Log: CPUID EDX: 0x178bfbff

2019-07-10 05:48:11 (1096): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-10 05:48:11 (1096): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-10 05:48:11 (1096): Guest Log: BIOS: Booting from Hard Disk...

2019-07-10 05:48:11 (1096): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-10 05:48:11 (1096): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-07-10 05:48:11 (1096): Successfully started VM. (PID = '8280')
2019-07-10 05:48:11 (1096): Reporting VM Process ID to BOINC.
2019-07-10 05:48:16 (1096): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-10 05:48:21 (1096): Detected: Web Application Enabled (http://localhost:60421)
2019-07-10 05:48:26 (1096): Preference change detected
2019-07-10 05:48:26 (1096): Setting CPU throttle for VM. (100%)
2019-07-10 05:48:26 (1096): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-10 05:48:36 (1096): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-07-10 05:48:46 (1096): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801acdda210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-10 05:48:46 (1096): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801aec88610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-10 05:48:46 (1096): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ace35a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-10 05:48:46 (1096): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801acddbe10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-10 05:50:16 (1096): Guest Log: Copying input files into RunAtlas.

2019-07-10 05:50:21 (1096): Guest Log: Copied input files into RunAtlas.

2019-07-10 05:50:31 (1096): Guest Log: copied the webapp to /var/www

2019-07-10 05:50:31 (1096): Guest Log: This vm does not need to setup http proxy

2019-07-10 05:50:31 (1096): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-10 05:50:36 (1096): Guest Log: Starting ATLAS job. (PandaID=4411271912 Binary file (standard input) matches)

2019-07-10 07:28:29 (1096): Status Report: Elapsed Time: '6002.635124'
2019-07-10 07:28:29 (1096): Status Report: CPU Time: '21054.984375'
2019-07-10 07:49:26 (1096): Stopping VM.
2019-07-10 07:50:04 (1096): Successfully stopped VM.
2019-07-10 08:06:53 (5584): vboxwrapper (7.9.26200): starting
2019-07-10 08:06:53 (5584): Feature: Checkpoint interval offset (334 seconds)
2019-07-10 08:06:53 (5584): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-10 08:06:53 (5584): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-10 08:06:53 (5584): Guest Log: BIOS: VirtualBox 5.2.8

2019-07-10 08:06:53 (5584): Guest Log: CPUID EDX: 0x178bfbff

2019-07-10 08:06:53 (5584): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-10 08:06:53 (5584): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-10 08:06:53 (5584): Guest Log: BIOS: Booting from Hard Disk...

2019-07-10 08:06:53 (5584): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-10 08:06:53 (5584): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-07-10 08:06:53 (5584): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-07-10 08:06:53 (5584): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801acdda210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-10 08:06:53 (5584): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801aec88610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-10 08:06:53 (5584): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ace35a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-10 08:06:53 (5584): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801acddbe10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-10 08:06:53 (5584): Guest Log: Copying input files into RunAtlas.

2019-07-10 08:06:53 (5584): Guest Log: Copied input files into RunAtlas.

2019-07-10 08:06:53 (5584): Guest Log: copied the webapp to /var/www

2019-07-10 08:06:53 (5584): Guest Log: This vm does not need to setup http proxy

2019-07-10 08:06:53 (5584): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-10 08:06:53 (5584): Guest Log: Starting ATLAS job. (PandaID=4411271912 Binary file (standard input) matches)

2019-07-10 08:06:53 (5584): Starting VM. (boinc_7b6bf2c1f45cc157, slot#4)
2019-07-10 08:07:21 (5584): Successfully started VM. (PID = '3200')
2019-07-10 08:07:21 (5584): Reporting VM Process ID to BOINC.
2019-07-10 08:07:26 (5584): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-10 08:07:31 (5584): Detected: Web Application Enabled (http://localhost:60421)
2019-07-10 08:07:36 (5584): Status Report: Elapsed Time: '7259.979553'
2019-07-10 08:07:36 (5584): Status Report: CPU Time: '26044.093750'
2019-07-10 08:07:36 (5584): Preference change detected
2019-07-10 08:07:36 (5584): Setting CPU throttle for VM. (100%)
2019-07-10 08:07:36 (5584): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-10 09:47:41 (5584): Status Report: Elapsed Time: '13264.698269'
2019-07-10 09:47:41 (5584): Status Report: CPU Time: '49905.406250'
2019-07-10 10:08:24 (5584): Stopping VM.
2019-07-10 10:09:03 (5584): Successfully stopped VM.
2019-07-10 10:28:25 (920): vboxwrapper (7.9.26200): starting
2019-07-10 10:28:25 (920): Feature: Checkpoint interval offset (55 seconds)
2019-07-10 10:28:25 (920): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-10 10:28:25 (920): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-10 10:28:25 (920): Starting VM. (boinc_7b6bf2c1f45cc157, slot#4)
2019-07-10 10:28:55 (920): Successfully started VM. (PID = '4100')
2019-07-10 10:28:55 (920): Reporting VM Process ID to BOINC.
2019-07-10 10:29:00 (920): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-10 10:29:05 (920): Detected: Web Application Enabled (http://localhost:60421)
2019-07-10 10:29:10 (920): Status Report: Elapsed Time: '14507.282343'
2019-07-10 10:29:10 (920): Status Report: CPU Time: '54896.875000'
2019-07-10 10:29:10 (920): Preference change detected
2019-07-10 10:29:10 (920): Setting CPU throttle for VM. (100%)
2019-07-10 10:29:10 (920): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-10 12:09:13 (920): Status Report: Elapsed Time: '20509.439600'
2019-07-10 12:09:13 (920): Status Report: CPU Time: '78775.359375'
2019-07-10 12:30:03 (920): Stopping VM.
2019-07-10 12:30:38 (920): Successfully stopped VM.
2019-07-10 12:50:02 (8284): vboxwrapper (7.9.26200): starting
2019-07-10 12:50:02 (8284): Feature: Checkpoint interval offset (496 seconds)
2019-07-10 12:50:02 (8284): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-10 12:50:02 (8284): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-10 12:50:02 (8284): Starting VM. (boinc_7b6bf2c1f45cc157, slot#4)
2019-07-10 12:50:34 (8284): Successfully started VM. (PID = '5536')
2019-07-10 12:50:34 (8284): Reporting VM Process ID to BOINC.
2019-07-10 12:50:39 (8284): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-10 12:50:44 (8284): Detected: Web Application Enabled (http://localhost:60421)
2019-07-10 12:50:49 (8284): Status Report: Elapsed Time: '21760.028282'
2019-07-10 12:50:49 (8284): Status Report: CPU Time: '83802.703125'
2019-07-10 12:50:49 (8284): Preference change detected
2019-07-10 12:50:49 (8284): Setting CPU throttle for VM. (100%)
2019-07-10 12:50:49 (8284): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-10 14:17:48 (8284): Guest Log: The last 10 lines of the pilot log.

2019-07-10 14:17:48 (8284): Guest Log: -rw-------  1 atlas01 atlas01 11357 Jun  3 19:18 LICENSE

2019-07-10 14:17:48 (8284): Guest Log: drwx------ 14 atlas01 atlas01  4096 Jul 10 05:51 pilot

2019-07-10 14:17:48 (8284): Guest Log: -rwx------  1 atlas01 atlas01 21401 Jun 19 12:31 pilot.py

2019-07-10 14:17:48 (8284): Guest Log: -rw-------  1 atlas01 atlas01     9 Jun 27 00:30 PILOTVERSION

2019-07-10 14:17:48 (8284): Guest Log: -rw-------  1 atlas01 atlas01  2251 Jun  3 19:18 README.md

2019-07-10 14:17:48 (8284): Guest Log: -rw-------  1 atlas01 atlas01   221 Jun  3 19:18 TODO.md

2019-07-10 14:17:48 (8284): Guest Log: 2019-07-10 12:17:46 UTC [wrapper] Test setup, not cleaning

2019-07-10 14:17:48 (8284): Guest Log: 2019-07-10 12:17:46 UTC [wrapper] ==== wrapper stdout END ====

2019-07-10 14:17:48 (8284): Guest Log: 2019-07-10 12:17:46 UTC [wrapper] ==== wrapper stderr END ====

2019-07-10 14:17:48 (8284): Guest Log: Listing of results directory

2019-07-10 14:17:48 (8284): Guest Log: total 504884

2019-07-10 14:17:48 (8284): Guest Log: drwx------ 5 atlas01 atlas01      4096 Jun 27 00:30 pilot2

2019-07-10 14:17:48 (8284): Guest Log: -rw-r--r-- 1 atlas01 atlas01   3736999 Jul  8 13:17 pilot2.tar.gz

2019-07-10 14:17:48 (8284): Guest Log: -rwx------ 1 atlas01 atlas01     15232 Jul 10 05:35 runpilot2-wrapper.sh

2019-07-10 14:17:48 (8284): Guest Log: -rw-r--r-- 1 atlas01 atlas01      4468 Jul 10 05:35 queuedata.json

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01      2872 Jul 10 05:35 pandaJobData.out

2019-07-10 14:17:48 (8284): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 375687617 Jul 10 05:50 EVNT.17323642._000476.pool.root.1

2019-07-10 14:17:48 (8284): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8728 Jul 10 05:50 init_data.xml

2019-07-10 14:17:48 (8284): Guest Log: -rwxr-xr-x 1 atlas01 atlas01   3745765 Jul 10 05:50 input.tar.gz

2019-07-10 14:17:48 (8284): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       815 Jul 10 05:50 RTE.tar.gz

2019-07-10 14:17:48 (8284): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8659 Jul 10 05:50 start_atlas.sh

2019-07-10 14:17:48 (8284): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Jul 10 05:50 APPS

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01   4644304 Jul 10 05:51 agis_schedconf.cvmfs.json

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01   7328357 Jul 10 05:51 agis_ddmendpoints.json

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01 114588106 Jul 10 14:15 HITS.18514543._024486.pool.root.1

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01       306 Jul 10 14:15 memory_monitor_summary.json

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01    864610 Jul 10 14:16 log.18514543._024486.job.log.tgz.1

2019-07-10 14:17:48 (8284): Guest Log: drwxrwx--- 3 atlas01 atlas01      4096 Jul 10 14:17 PanDA_Pilot-4411271912

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01     87560 Jul 10 14:17 heartbeat.json

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01   1291293 Jul 10 14:17 pilotlog.txt

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01   1307870 Jul 10 14:17 log.18514543._024486.job.log.1

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01       512 Jul 10 14:17 I3VKDmmZI5unShfckohDCDFpABFKDmABFKDmj2gUDmABFKDmJc9Ojm.diag

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01       391 Jul 10 14:17 output.list

2019-07-10 14:17:48 (8284): Guest Log: -rw-r--r-- 1 atlas01 atlas01      6829 Jul 10 14:17 runtime_log.err

2019-07-10 14:17:48 (8284): Guest Log: -rw-r--r-- 1 atlas01 atlas01       692 Jul 10 14:17 runtime_log

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01   3584000 Jul 10 14:17 result.tar.gz

2019-07-10 14:17:48 (8284): Guest Log: HITS file was successfully produced

2019-07-10 14:17:48 (8284): Guest Log: -rw------- 1 atlas01 atlas01 114588106 Jul 10 14:15 /home/atlas01/RunAtlas/HITS.18514543._024486.pool.root.1

2019-07-10 14:17:48 (8284): Guest Log: Successfully finished the ATLAS job!

2019-07-10 14:17:48 (8284): Guest Log: Copying the results back to the shared directory!

2019-07-10 14:17:53 (8284): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-07-10 14:17:53 (8284): Guest Log: Success! Shutting down the machine.

2019-07-10 14:17:53 (8284): VM Completion File Detected.
2019-07-10 14:17:53 (8284): Powering off VM.
2019-07-10 14:17:54 (8284): Successfully stopped VM.
2019-07-10 14:17:59 (8284): Deregistering VM. (boinc_7b6bf2c1f45cc157, slot#4)
2019-07-10 14:17:59 (8284): Removing virtual disk drive(s) from VM.
2019-07-10 14:17:59 (8284): Removing network bandwidth throttle group from VM.
2019-07-10 14:17:59 (8284): Removing storage controller(s) from VM.
2019-07-10 14:17:59 (8284): Removing VM from VirtualBox.
14:18:04 (8284): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN