Stderr output

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

2019-07-25 19:43:11 (5676): Guest Log: CPUID EDX: 0x178bfbff

2019-07-25 19:43:11 (5676): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-25 19:43:11 (5676): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-25 19:43:11 (5676): Guest Log: BIOS: Booting from Hard Disk...

2019-07-25 19:43:11 (5676): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-25 19:43:11 (5676): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-07-25 19:43:12 (5676): Successfully started VM. (PID = '10252')
2019-07-25 19:43:12 (5676): Reporting VM Process ID to BOINC.
2019-07-25 19:43:17 (5676): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-25 19:43:22 (5676): Detected: Web Application Enabled (http://localhost:55096)
2019-07-25 19:43:27 (5676): Preference change detected
2019-07-25 19:43:27 (5676): Setting CPU throttle for VM. (95%)
2019-07-25 19:43:27 (5676): Setting checkpoint interval to 1200 seconds. (Higher value of (Preference: 1200 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-25 19:43:32 (5676): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-07-25 19:43:42 (5676): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801b27a7c10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-25 19:43:42 (5676): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ac6be810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-25 19:43:42 (5676): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae571a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-25 19:43:42 (5676): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ac6bec10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-25 19:44:07 (5676): Guest Log: Copying input files into RunAtlas.

2019-07-25 19:44:13 (5676): Guest Log: Copied input files into RunAtlas.

2019-07-25 19:44:33 (5676): Guest Log: copied the webapp to /var/www

2019-07-25 19:44:33 (5676): Guest Log: This vm does not need to setup http proxy

2019-07-25 19:44:33 (5676): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-25 19:44:33 (5676): Guest Log: Starting ATLAS job. (PandaID=4425609470 Binary file (standard input) matches)

2019-07-25 21:11:51 (5676): Stopping VM.
2019-07-25 21:12:34 (5676): Successfully stopped VM.
2019-07-26 01:23:30 (9948): vboxwrapper (7.9.26200): starting
2019-07-26 01:23:30 (9948): Feature: Checkpoint interval offset (595 seconds)
2019-07-26 01:23:30 (9948): Detected: VirtualBox COM Interface (Version: 5.2.28)
2019-07-26 01:23:30 (9948): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-26 01:23:30 (9948): Guest Log: BIOS: VirtualBox 5.2.28

2019-07-26 01:23:30 (9948): Guest Log: CPUID EDX: 0x178bfbff

2019-07-26 01:23:30 (9948): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-26 01:23:30 (9948): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-26 01:23:30 (9948): Guest Log: BIOS: Booting from Hard Disk...

2019-07-26 01:23:30 (9948): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-26 01:23:30 (9948): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-07-26 01:23:30 (9948): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-07-26 01:23:30 (9948): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801b27a7c10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-26 01:23:30 (9948): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ac6be810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-26 01:23:30 (9948): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae571a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-26 01:23:30 (9948): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ac6bec10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-26 01:23:30 (9948): Guest Log: Copying input files into RunAtlas.

2019-07-26 01:23:30 (9948): Guest Log: Copied input files into RunAtlas.

2019-07-26 01:23:30 (9948): Guest Log: copied the webapp to /var/www

2019-07-26 01:23:30 (9948): Guest Log: This vm does not need to setup http proxy

2019-07-26 01:23:30 (9948): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-26 01:23:30 (9948): Guest Log: Starting ATLAS job. (PandaID=4425609470 Binary file (standard input) matches)

2019-07-26 01:23:30 (9948): Starting VM. (boinc_b71673f0724c0b15, slot#5)
2019-07-26 01:24:08 (9948): Successfully started VM. (PID = '5664')
2019-07-26 01:24:08 (9948): Reporting VM Process ID to BOINC.
2019-07-26 01:24:13 (9948): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-26 01:24:18 (9948): Detected: Web Application Enabled (http://localhost:55096)
2019-07-26 01:24:23 (9948): Preference change detected
2019-07-26 01:24:23 (9948): Setting CPU throttle for VM. (95%)
2019-07-26 01:24:23 (9948): Setting checkpoint interval to 1200 seconds. (Higher value of (Preference: 1200 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-26 01:36:01 (9948): Status Report: Elapsed Time: '6001.670116'
2019-07-26 01:36:01 (9948): Status Report: CPU Time: '18389.812500'
2019-07-26 03:16:04 (9948): Status Report: Elapsed Time: '12004.758024'
2019-07-26 03:16:04 (9948): Status Report: CPU Time: '41107.109375'
2019-07-26 03:39:37 (9948): Guest Log: The last 10 lines of the pilot log.

2019-07-26 03:39:37 (9948): Guest Log: -rw-------  1 atlas01 atlas01 11357 Jun  3 19:18 LICENSE

2019-07-26 03:39:37 (9948): Guest Log: drwx------ 14 atlas01 atlas01  4096 Jul 25 19:45 pilot

2019-07-26 03:39:37 (9948): Guest Log: -rwx------  1 atlas01 atlas01 20463 Jul 23 12:01 pilot.py

2019-07-26 03:39:37 (9948): Guest Log: -rw-------  1 atlas01 atlas01     8 Jul 23 12:01 PILOTVERSION

2019-07-26 03:39:37 (9948): Guest Log: -rw-------  1 atlas01 atlas01  2251 Jun  3 19:18 README.md

2019-07-26 03:39:37 (9948): Guest Log: -rw-------  1 atlas01 atlas01   221 Jun  3 19:18 TODO.md

2019-07-26 03:39:37 (9948): Guest Log: 2019-07-26 01:39:35 UTC [wrapper] Test setup, not cleaning

2019-07-26 03:39:37 (9948): Guest Log: 2019-07-26 01:39:35 UTC [wrapper] ==== wrapper stdout END ====

2019-07-26 03:39:37 (9948): Guest Log: 2019-07-26 01:39:35 UTC [wrapper] ==== wrapper stderr END ====

2019-07-26 03:39:37 (9948): Guest Log: Listing of results directory

2019-07-26 03:39:37 (9948): Guest Log: total 501372

2019-07-26 03:39:37 (9948): Guest Log: drwx------ 5 atlas01 atlas01      4096 Jul 23 12:01 pilot2

2019-07-26 03:39:37 (9948): Guest Log: -rw-r--r-- 1 atlas01 atlas01   4292892 Jul 24 13:27 pilot2.tar.gz

2019-07-26 03:39:37 (9948): Guest Log: -rw-r--r-- 1 atlas01 atlas01      4468 Jul 24 21:10 queuedata.json

2019-07-26 03:39:37 (9948): Guest Log: -rwx------ 1 atlas01 atlas01     15232 Jul 24 21:16 runpilot2-wrapper.sh

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01      2885 Jul 24 21:16 pandaJobData.out

2019-07-26 03:39:37 (9948): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 376903642 Jul 25 19:44 EVNT.17323836._000752.pool.root.1

2019-07-26 03:39:37 (9948): Guest Log: -rwxr-xr-x 1 atlas01 atlas01     12380 Jul 25 19:44 init_data.xml

2019-07-26 03:39:37 (9948): Guest Log: -rwxr-xr-x 1 atlas01 atlas01   4302240 Jul 25 19:44 input.tar.gz

2019-07-26 03:39:37 (9948): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       815 Jul 25 19:44 RTE.tar.gz

2019-07-26 03:39:37 (9948): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8659 Jul 25 19:44 start_atlas.sh

2019-07-26 03:39:37 (9948): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Jul 25 19:44 APPS

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01   4582636 Jul 25 19:45 agis_schedconf.cvmfs.json

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01   7414901 Jul 25 19:45 agis_ddmendpoints.json

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01 111838775 Jul 26 03:36 HITS.18605005._031752.pool.root.1

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01    800319 Jul 26 03:38 log.18605005._031752.job.log.tgz.1

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01     55548 Jul 26 03:38 heartbeat.json

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01      7955 Jul 26 03:39 pilotlog.txt

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01    736652 Jul 26 03:39 log.18605005._031752.job.log.1

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01       512 Jul 26 03:39 oHjLDmtvbAvnShfckohDCDFpABFKDmABFKDmrnhKDmABFKDmzIth9n.diag

2019-07-26 03:39:37 (9948): Guest Log: -rw-r--r-- 1 atlas01 atlas01      6789 Jul 26 03:39 runtime_log.err

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01       391 Jul 26 03:39 output.list

2019-07-26 03:39:37 (9948): Guest Log: -rw-r--r-- 1 atlas01 atlas01       692 Jul 26 03:39 runtime_log

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01   2344960 Jul 26 03:39 result.tar.gz

2019-07-26 03:39:37 (9948): Guest Log: HITS file was successfully produced

2019-07-26 03:39:37 (9948): Guest Log: -rw------- 1 atlas01 atlas01 111838775 Jul 26 03:36 /home/atlas01/RunAtlas/HITS.18605005._031752.pool.root.1

2019-07-26 03:39:37 (9948): Guest Log: Successfully finished the ATLAS job!

2019-07-26 03:39:37 (9948): Guest Log: Copying the results back to the shared directory!

2019-07-26 03:39:37 (9948): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-07-26 03:39:37 (9948): Guest Log: Success! Shutting down the machine.

2019-07-26 03:39:37 (9948): VM Completion File Detected.
2019-07-26 03:39:37 (9948): Powering off VM.
2019-07-26 03:39:40 (9948): Successfully stopped VM.
2019-07-26 03:39:45 (9948): Deregistering VM. (boinc_b71673f0724c0b15, slot#5)
2019-07-26 03:39:45 (9948): Removing virtual disk drive(s) from VM.
2019-07-26 03:39:45 (9948): Removing network bandwidth throttle group from VM.
2019-07-26 03:39:45 (9948): Removing storage controller(s) from VM.
2019-07-26 03:39:45 (9948): Removing VM from VirtualBox.
03:39:50 (9948): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN