Stderr output

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

2019-07-17 05:06:07 (19180): Guest Log: CPUID EDX: 0x178bfbff

2019-07-17 05:06:07 (19180): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-17 05:06:07 (19180): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-17 05:06:07 (19180): Guest Log: BIOS: Booting from Hard Disk...

2019-07-17 05:06:07 (19180): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-17 05:06:07 (19180): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

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

2019-07-17 05:06:42 (19180): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae67ae10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 05:06:42 (19180): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ac386810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 05:06:42 (19180): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ac386610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 05:06:42 (19180): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae67ba10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 05:07:17 (19180): Guest Log: Copying input files into RunAtlas.

2019-07-17 05:07:22 (19180): Guest Log: Copied input files into RunAtlas.

2019-07-17 05:07:47 (19180): Guest Log: copied the webapp to /var/www

2019-07-17 05:07:47 (19180): Guest Log: This vm does not need to setup http proxy

2019-07-17 05:07:52 (19180): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-17 05:07:52 (19180): Guest Log: Starting ATLAS job. (PandaID=4418461699 Binary file (standard input) matches)

2019-07-17 06:46:27 (19180): Status Report: Elapsed Time: '6004.922020'
2019-07-17 06:46:27 (19180): Status Report: CPU Time: '20951.312500'
2019-07-17 08:26:27 (19180): Status Report: Elapsed Time: '12005.146107'
2019-07-17 08:26:27 (19180): Status Report: CPU Time: '44716.921875'
2019-07-17 10:06:27 (19180): Status Report: Elapsed Time: '18005.193979'
2019-07-17 10:06:27 (19180): Status Report: CPU Time: '68691.515625'
2019-07-17 10:16:03 (19180): Stopping VM.
2019-07-17 10:16:44 (19180): Successfully stopped VM.
2019-07-17 11:06:18 (24356): vboxwrapper (7.9.26200): starting
2019-07-17 11:06:18 (24356): Feature: Checkpoint interval offset (257 seconds)
2019-07-17 11:06:18 (24356): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-17 11:06:18 (24356): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-17 11:06:18 (24356): Guest Log: BIOS: VirtualBox 5.2.8

2019-07-17 11:06:18 (24356): Guest Log: CPUID EDX: 0x178bfbff

2019-07-17 11:06:18 (24356): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-17 11:06:18 (24356): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-17 11:06:18 (24356): Guest Log: BIOS: Booting from Hard Disk...

2019-07-17 11:06:18 (24356): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-17 11:06:18 (24356): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-07-17 11:06:18 (24356): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-07-17 11:06:18 (24356): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae67ae10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 11:06:18 (24356): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ac386810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 11:06:18 (24356): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ac386610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 11:06:18 (24356): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae67ba10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 11:06:18 (24356): Guest Log: Copying input files into RunAtlas.

2019-07-17 11:06:18 (24356): Guest Log: Copied input files into RunAtlas.

2019-07-17 11:06:18 (24356): Guest Log: copied the webapp to /var/www

2019-07-17 11:06:18 (24356): Guest Log: This vm does not need to setup http proxy

2019-07-17 11:06:18 (24356): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-17 11:06:18 (24356): Guest Log: Starting ATLAS job. (PandaID=4418461699 Binary file (standard input) matches)

2019-07-17 11:06:18 (24356): Starting VM. (boinc_6111c97138398ff1, slot#4)
2019-07-17 11:06:45 (24356): Successfully started VM. (PID = '25000')
2019-07-17 11:06:45 (24356): Reporting VM Process ID to BOINC.
2019-07-17 11:06:50 (24356): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-17 11:06:55 (24356): Detected: Web Application Enabled (http://localhost:50529)
2019-07-17 11:07:00 (24356): Status Report: Elapsed Time: '18581.226984'
2019-07-17 11:07:00 (24356): Status Report: CPU Time: '71091.015625'
2019-07-17 11:07:00 (24356): Preference change detected
2019-07-17 11:07:00 (24356): Setting CPU throttle for VM. (100%)
2019-07-17 11:07:01 (24356): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-17 12:47:01 (24356): Status Report: Elapsed Time: '24581.905342'
2019-07-17 12:47:01 (24356): Status Report: CPU Time: '94943.546875'
2019-07-17 13:07:38 (24356): Stopping VM.
2019-07-17 13:08:20 (24356): Successfully stopped VM.
2019-07-17 14:37:39 (18788): vboxwrapper (7.9.26200): starting
2019-07-17 14:37:39 (18788): Feature: Checkpoint interval offset (524 seconds)
2019-07-17 14:37:39 (18788): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-17 14:37:39 (18788): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-17 14:37:39 (18788): Starting VM. (boinc_6111c97138398ff1, slot#4)
2019-07-17 14:38:07 (18788): Successfully started VM. (PID = '26136')
2019-07-17 14:38:07 (18788): Reporting VM Process ID to BOINC.
2019-07-17 14:38:12 (18788): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-17 14:38:17 (18788): Detected: Web Application Enabled (http://localhost:50529)
2019-07-17 14:38:22 (18788): Status Report: Elapsed Time: '25818.832142'
2019-07-17 14:38:22 (18788): Status Report: CPU Time: '99943.718750'
2019-07-17 14:38:22 (18788): Preference change detected
2019-07-17 14:38:22 (18788): Setting CPU throttle for VM. (100%)
2019-07-17 14:38:22 (18788): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-17 15:19:02 (18788): Guest Log: The last 10 lines of the pilot log.

2019-07-17 15:19:02 (18788): Guest Log: -rw-------  1 atlas01 atlas01 11357 Jun  3 19:18 LICENSE

2019-07-17 15:19:02 (18788): Guest Log: drwx------ 14 atlas01 atlas01  4096 Jul 17 05:09 pilot

2019-07-17 15:19:02 (18788): Guest Log: -rwx------  1 atlas01 atlas01 21428 Jul 11 17:38 pilot.py

2019-07-17 15:19:02 (18788): Guest Log: -rw-------  1 atlas01 atlas01     8 Jul 15 15:01 PILOTVERSION

2019-07-17 15:19:02 (18788): Guest Log: -rw-------  1 atlas01 atlas01  2251 Jun  3 19:18 README.md

2019-07-17 15:19:02 (18788): Guest Log: -rw-------  1 atlas01 atlas01   221 Jun  3 19:18 TODO.md

2019-07-17 15:19:02 (18788): Guest Log: 2019-07-17 13:19:00 UTC [wrapper] Test setup, not cleaning

2019-07-17 15:19:02 (18788): Guest Log: 2019-07-17 13:19:00 UTC [wrapper] ==== wrapper stdout END ====

2019-07-17 15:19:02 (18788): Guest Log: 2019-07-17 13:19:00 UTC [wrapper] ==== wrapper stderr END ====

2019-07-17 15:19:02 (18788): Guest Log: Listing of results directory

2019-07-17 15:19:02 (18788): Guest Log: total 506500

2019-07-17 15:19:02 (18788): Guest Log: drwx------ 5 atlas01 atlas01      4096 Jul 15 15:01 pilot2

2019-07-17 15:19:02 (18788): Guest Log: -rw-r--r-- 1 atlas01 atlas01   4056709 Jul 16 15:21 pilot2.tar.gz

2019-07-17 15:19:02 (18788): Guest Log: -rw-r--r-- 1 atlas01 atlas01      4468 Jul 16 22:36 queuedata.json

2019-07-17 15:19:02 (18788): Guest Log: -rwx------ 1 atlas01 atlas01     15232 Jul 16 22:37 runpilot2-wrapper.sh

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01      2870 Jul 16 22:37 pandaJobData.out

2019-07-17 15:19:02 (18788): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 378835281 Jul 17 05:07 EVNT.17323806._000876.pool.root.1

2019-07-17 15:19:02 (18788): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8726 Jul 17 05:07 init_data.xml

2019-07-17 15:19:02 (18788): Guest Log: -rwxr-xr-x 1 atlas01 atlas01   4066489 Jul 17 05:07 input.tar.gz

2019-07-17 15:19:02 (18788): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       815 Jul 17 05:07 RTE.tar.gz

2019-07-17 15:19:02 (18788): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8659 Jul 17 05:07 start_atlas.sh

2019-07-17 15:19:02 (18788): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Jul 17 05:07 APPS

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01   4671042 Jul 17 05:09 agis_schedconf.cvmfs.json

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01   7348204 Jul 17 05:09 agis_ddmendpoints.json

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01 112068789 Jul 17 15:15 HITS.18514574._043199.pool.root.1

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01    848272 Jul 17 15:17 log.18514574._043199.job.log.tgz.1

2019-07-17 15:19:02 (18788): Guest Log: drwxrwx--- 3 atlas01 atlas01      4096 Jul 17 15:18 PanDA_Pilot-4418461699

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01     88713 Jul 17 15:18 heartbeat.json

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01   1387770 Jul 17 15:19 pilotlog.txt

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01   1404534 Jul 17 15:19 log.18514574._043199.job.log.1

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01       513 Jul 17 15:19 V1jLDm5Nj7unShfckohDCDFpABFKDmABFKDmgAuYDmABFKDmwhQJDo.diag

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01       391 Jul 17 15:19 output.list

2019-07-17 15:19:02 (18788): Guest Log: -rw-r--r-- 1 atlas01 atlas01      6829 Jul 17 15:19 runtime_log.err

2019-07-17 15:19:02 (18788): Guest Log: -rw-r--r-- 1 atlas01 atlas01       692 Jul 17 15:19 runtime_log

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01   3758080 Jul 17 15:19 result.tar.gz

2019-07-17 15:19:02 (18788): Guest Log: HITS file was successfully produced

2019-07-17 15:19:02 (18788): Guest Log: -rw------- 1 atlas01 atlas01 112068789 Jul 17 15:15 /home/atlas01/RunAtlas/HITS.18514574._043199.pool.root.1

2019-07-17 15:19:07 (18788): Guest Log: Successfully finished the ATLAS job!

2019-07-17 15:19:07 (18788): Guest Log: Copying the results back to the shared directory!

2019-07-17 15:19:07 (18788): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-07-17 15:19:07 (18788): Guest Log: Success! Shutting down the machine.

2019-07-17 15:19:07 (18788): VM Completion File Detected.
2019-07-17 15:19:07 (18788): Powering off VM.
2019-07-17 15:19:09 (18788): Successfully stopped VM.
2019-07-17 15:19:14 (18788): Deregistering VM. (boinc_6111c97138398ff1, slot#4)
2019-07-17 15:19:14 (18788): Removing virtual disk drive(s) from VM.
2019-07-17 15:19:14 (18788): Removing network bandwidth throttle group from VM.
2019-07-17 15:19:14 (18788): Removing storage controller(s) from VM.
2019-07-17 15:19:14 (18788): Removing VM from VirtualBox.
15:19:19 (18788): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN