Stderr output

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

2019-07-14 06:57:33 (4716): Guest Log: CPUID EDX: 0x178bfbff

2019-07-14 06:57:33 (4716): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-14 06:57:33 (4716): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-14 06:57:33 (4716): Guest Log: BIOS: Booting from Hard Disk...

2019-07-14 06:57:33 (4716): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-14 06:57:33 (4716): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-07-14 06:57:33 (4716): Successfully started VM. (PID = '9096')
2019-07-14 06:57:33 (4716): Reporting VM Process ID to BOINC.
2019-07-14 06:57:38 (4716): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-14 06:57:43 (4716): Detected: Web Application Enabled (http://localhost:52480)
2019-07-14 06:57:48 (4716): Preference change detected
2019-07-14 06:57:48 (4716): Setting CPU throttle for VM. (100%)
2019-07-14 06:57:49 (4716): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-14 06:57:59 (4716): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-07-14 06:58:09 (4716): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ad2bbc10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-14 06:58:09 (4716): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ace02810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-14 06:58:09 (4716): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ace02610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-14 06:58:09 (4716): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ace02410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-14 06:59:14 (4716): Guest Log: Copying input files into RunAtlas.

2019-07-14 06:59:19 (4716): Guest Log: Copied input files into RunAtlas.

2019-07-14 06:59:44 (4716): Guest Log: copied the webapp to /var/www

2019-07-14 06:59:44 (4716): Guest Log: This vm does not need to setup http proxy

2019-07-14 06:59:44 (4716): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-14 06:59:44 (4716): Guest Log: Starting ATLAS job. (PandaID=4415642345 taskID=18604976)

2019-07-14 08:37:50 (4716): Status Report: Elapsed Time: '6001.478008'
2019-07-14 08:37:50 (4716): Status Report: CPU Time: '21026.421875'
2019-07-14 10:17:53 (4716): Status Report: Elapsed Time: '12004.409733'
2019-07-14 10:17:53 (4716): Status Report: CPU Time: '44928.640625'
2019-07-14 11:57:54 (4716): Status Report: Elapsed Time: '18005.454996'
2019-07-14 11:57:54 (4716): Status Report: CPU Time: '68749.531250'
2019-07-14 11:58:40 (4716): Stopping VM.
2019-07-14 11:59:33 (4716): Successfully stopped VM.
2019-07-14 12:01:49 (12760): vboxwrapper (7.9.26200): starting
2019-07-14 12:01:49 (12760): Feature: Checkpoint interval offset (163 seconds)
2019-07-14 12:01:49 (12760): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-14 12:01:49 (12760): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-14 12:01:49 (12760): Guest Log: BIOS: VirtualBox 5.2.8

2019-07-14 12:01:49 (12760): Guest Log: CPUID EDX: 0x178bfbff

2019-07-14 12:01:49 (12760): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-14 12:01:49 (12760): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-14 12:01:49 (12760): Guest Log: BIOS: Booting from Hard Disk...

2019-07-14 12:01:49 (12760): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-14 12:01:49 (12760): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-07-14 12:01:49 (12760): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-07-14 12:01:49 (12760): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ad2bbc10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-14 12:01:49 (12760): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ace02810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-14 12:01:49 (12760): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ace02610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-14 12:01:49 (12760): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ace02410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-14 12:01:49 (12760): Guest Log: Copying input files into RunAtlas.

2019-07-14 12:01:49 (12760): Guest Log: Copied input files into RunAtlas.

2019-07-14 12:01:49 (12760): Guest Log: copied the webapp to /var/www

2019-07-14 12:01:49 (12760): Guest Log: This vm does not need to setup http proxy

2019-07-14 12:01:49 (12760): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-14 12:01:49 (12760): Guest Log: Starting ATLAS job. (PandaID=4415642345 taskID=18604976)

2019-07-14 12:01:49 (12760): Starting VM. (boinc_b46b8ddd115699ae, slot#1)
2019-07-14 12:02:19 (12760): Successfully started VM. (PID = '12932')
2019-07-14 12:02:19 (12760): Reporting VM Process ID to BOINC.
2019-07-14 12:02:24 (12760): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-14 12:02:29 (12760): Detected: Web Application Enabled (http://localhost:52480)
2019-07-14 12:02:34 (12760): Status Report: Elapsed Time: '18051.180332'
2019-07-14 12:02:34 (12760): Status Report: CPU Time: '68945.703125'
2019-07-14 12:02:34 (12760): Preference change detected
2019-07-14 12:02:34 (12760): Setting CPU throttle for VM. (100%)
2019-07-14 12:02:34 (12760): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-14 13:42:38 (12760): Status Report: Elapsed Time: '24055.523283'
2019-07-14 13:42:38 (12760): Status Report: CPU Time: '92603.515625'
2019-07-14 14:04:42 (12760): Stopping VM.
2019-07-14 14:05:30 (12760): Successfully stopped VM.
2019-07-14 15:07:53 (12324): vboxwrapper (7.9.26200): starting
2019-07-14 15:07:53 (12324): Feature: Checkpoint interval offset (137 seconds)
2019-07-14 15:07:53 (12324): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-14 15:07:53 (12324): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-14 15:07:53 (12324): Starting VM. (boinc_b46b8ddd115699ae, slot#1)
2019-07-14 15:08:30 (12324): Successfully started VM. (PID = '13176')
2019-07-14 15:08:30 (12324): Reporting VM Process ID to BOINC.
2019-07-14 15:08:35 (12324): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-14 15:08:40 (12324): Detected: Web Application Enabled (http://localhost:52480)
2019-07-14 15:08:45 (12324): Status Report: Elapsed Time: '25379.153904'
2019-07-14 15:08:45 (12324): Status Report: CPU Time: '97976.546875'
2019-07-14 15:08:45 (12324): Preference change detected
2019-07-14 15:08:45 (12324): Setting CPU throttle for VM. (100%)
2019-07-14 15:08:45 (12324): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-14 15:40:25 (12324): Guest Log: The last 10 lines of the pilot log.

2019-07-14 15:40:25 (12324): Guest Log: -rw-------  1 atlas01 atlas01 11357 Jun  3 19:18 LICENSE

2019-07-14 15:40:25 (12324): Guest Log: drwx------ 14 atlas01 atlas01  4096 Jul 14 07:00 pilot

2019-07-14 15:40:25 (12324): Guest Log: -rwx------  1 atlas01 atlas01 21428 Jul 11 17:38 pilot.py

2019-07-14 15:40:25 (12324): Guest Log: -rw-------  1 atlas01 atlas01     8 Jul 11 17:38 PILOTVERSION

2019-07-14 15:40:25 (12324): Guest Log: -rw-------  1 atlas01 atlas01  2251 Jun  3 19:18 README.md

2019-07-14 15:40:25 (12324): Guest Log: -rw-------  1 atlas01 atlas01   221 Jun  3 19:18 TODO.md

2019-07-14 15:40:25 (12324): Guest Log: 2019-07-14 13:40:21 UTC [wrapper] Test setup, not cleaning

2019-07-14 15:40:25 (12324): Guest Log: 2019-07-14 13:40:21 UTC [wrapper] ==== wrapper stdout END ====

2019-07-14 15:40:25 (12324): Guest Log: 2019-07-14 13:40:21 UTC [wrapper] ==== wrapper stderr END ====

2019-07-14 15:40:25 (12324): Guest Log: Listing of results directory

2019-07-14 15:40:25 (12324): Guest Log: total 500468

2019-07-14 15:40:25 (12324): Guest Log: drwx------ 5 atlas01 atlas01      4096 Jul 11 17:38 pilot2

2019-07-14 15:40:25 (12324): Guest Log: -rw-r--r-- 1 atlas01 atlas01   3989187 Jul 12 15:19 pilot2.tar.gz

2019-07-14 15:40:25 (12324): Guest Log: -rwx------ 1 atlas01 atlas01     15232 Jul 14 02:35 runpilot2-wrapper.sh

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01      2868 Jul 14 02:35 pandaJobData.out

2019-07-14 15:40:25 (12324): Guest Log: -rw-r--r-- 1 atlas01 atlas01      4468 Jul 14 02:35 queuedata.json

2019-07-14 15:40:25 (12324): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 378133275 Jul 14 06:59 EVNT.17323813._000025.pool.root.1

2019-07-14 15:40:25 (12324): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8727 Jul 14 06:59 init_data.xml

2019-07-14 15:40:25 (12324): Guest Log: -rwxr-xr-x 1 atlas01 atlas01   3998998 Jul 14 06:59 input.tar.gz

2019-07-14 15:40:25 (12324): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       815 Jul 14 06:59 RTE.tar.gz

2019-07-14 15:40:25 (12324): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8659 Jul 14 06:59 start_atlas.sh

2019-07-14 15:40:25 (12324): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Jul 14 06:59 APPS

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01   4650392 Jul 14 07:00 agis_schedconf.cvmfs.json

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01   7330415 Jul 14 07:00 agis_ddmendpoints.json

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01 107132853 Jul 14 15:36 HITS.18604976._001198.pool.root.1

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01    845475 Jul 14 15:39 log.18604976._001198.job.log.tgz.1

2019-07-14 15:40:25 (12324): Guest Log: drwxrwx--- 3 atlas01 atlas01      4096 Jul 14 15:40 PanDA_Pilot-4415642345

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01     58453 Jul 14 15:40 heartbeat.json

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01   1310303 Jul 14 15:40 pilotlog.txt

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01   1326880 Jul 14 15:40 log.18604976._001198.job.log.1

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01       513 Jul 14 15:40 weLMDmjfh6unShfckohDCDFpABFKDmABFKDm2QJXDmABFKDmepsacn.diag

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01       391 Jul 14 15:40 output.list

2019-07-14 15:40:25 (12324): Guest Log: -rw-r--r-- 1 atlas01 atlas01      6829 Jul 14 15:40 runtime_log.err

2019-07-14 15:40:25 (12324): Guest Log: -rw-r--r-- 1 atlas01 atlas01       692 Jul 14 15:40 runtime_log

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01   3573760 Jul 14 15:40 result.tar.gz

2019-07-14 15:40:25 (12324): Guest Log: HITS file was successfully produced

2019-07-14 15:40:25 (12324): Guest Log: -rw------- 1 atlas01 atlas01 107132853 Jul 14 15:36 /home/atlas01/RunAtlas/HITS.18604976._001198.pool.root.1

2019-07-14 15:40:25 (12324): Guest Log: Successfully finished the ATLAS job!

2019-07-14 15:40:25 (12324): Guest Log: Copying the results back to the shared directory!

2019-07-14 15:40:25 (12324): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-07-14 15:40:25 (12324): Guest Log: Success! Shutting down the machine.

2019-07-14 15:40:25 (12324): VM Completion File Detected.
2019-07-14 15:40:25 (12324): Powering off VM.
2019-07-14 15:40:27 (12324): Successfully stopped VM.
2019-07-14 15:40:32 (12324): Deregistering VM. (boinc_b46b8ddd115699ae, slot#1)
2019-07-14 15:40:32 (12324): Removing virtual disk drive(s) from VM.
2019-07-14 15:40:32 (12324): Removing network bandwidth throttle group from VM.
2019-07-14 15:40:32 (12324): Removing storage controller(s) from VM.
2019-07-14 15:40:32 (12324): Removing VM from VirtualBox.
15:40:37 (12324): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN