Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-07-21 05:34:31 (10612): vboxwrapper (7.9.26200): starting
2019-07-21 05:34:32 (10612): Feature: Checkpoint interval offset (35 seconds)
2019-07-21 05:34:32 (10612): Detected: VirtualBox COM Interface (Version: 5.2.26)
2019-07-21 05:34:32 (10612): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-21 05:34:32 (10612): Successfully copied 'init_data.xml' to the shared directory.
2019-07-21 05:34:32 (10612): Create VM. (boinc_06e7ebbb0e042487, slot#29)
2019-07-21 05:34:32 (10612): Setting Memory Size for VM. (3900MB)
2019-07-21 05:34:32 (10612): Setting CPU Count for VM. (1)
2019-07-21 05:34:32 (10612): Setting Chipset Options for VM.
2019-07-21 05:34:32 (10612): Setting Boot Options for VM.
2019-07-21 05:34:32 (10612): Enabling VM Network Access.
2019-07-21 05:34:32 (10612): Setting Network Configuration for NAT.
2019-07-21 05:34:32 (10612): Disabling USB Support for VM.
2019-07-21 05:34:32 (10612): Disabling COM Port Support for VM.
2019-07-21 05:34:32 (10612): Disabling LPT Port Support for VM.
2019-07-21 05:34:32 (10612): Disabling Audio Support for VM.
2019-07-21 05:34:32 (10612): Disabling Clipboard Support for VM.
2019-07-21 05:34:32 (10612): Disabling Drag and Drop Support for VM.
2019-07-21 05:34:32 (10612): Adding storage controller(s) to VM.
2019-07-21 05:34:32 (10612): Adding virtual disk drive to VM. (vm_image.vdi)
2019-07-21 05:34:32 (10612): Adding VirtualBox Guest Additions to VM.
2019-07-21 05:34:32 (10612): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-07-21 05:34:32 (10612): forwarding host port 64075 to guest port 80
2019-07-21 05:34:32 (10612): Enabling remote desktop for VM.
2019-07-21 05:34:32 (10612): Enabling shared directory for VM.
2019-07-21 05:34:33 (10612): Starting VM. (boinc_06e7ebbb0e042487, slot#29)
2019-07-21 05:34:47 (10612): Guest Log: BIOS: VirtualBox 5.2.26

2019-07-21 05:34:47 (10612): Guest Log: CPUID EDX: 0x078bfbff

2019-07-21 05:34:47 (10612): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-21 05:34:47 (10612): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-21 05:34:47 (10612): Guest Log: BIOS: Booting from Hard Disk...

2019-07-21 05:34:47 (10612): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-21 05:34:47 (10612): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-07-21 05:34:47 (10612): Successfully started VM. (PID = '12336')
2019-07-21 05:34:47 (10612): Reporting VM Process ID to BOINC.
2019-07-21 05:34:52 (10612): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-21 05:34:57 (10612): Detected: Web Application Enabled (http://localhost:64075)
2019-07-21 05:34:57 (10612): Detected: Remote Desktop Enabled (localhost:64076)
2019-07-21 05:35:03 (10612): Preference change detected
2019-07-21 05:35:03 (10612): Setting CPU throttle for VM. (100%)
2019-07-21 05:35:03 (10612): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-21 05:35:08 (10612): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-07-21 05:35:18 (10612): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880108309010), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-21 05:35:18 (10612): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880108309410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-21 05:35:18 (10612): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880108309610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-21 05:35:18 (10612): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880108309610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-21 05:36:14 (10612): Guest Log: Copying input files into RunAtlas.

2019-07-21 05:36:24 (10612): Guest Log: Copied input files into RunAtlas.

2019-07-21 05:36:44 (10612): Guest Log: copied the webapp to /var/www

2019-07-21 05:36:44 (10612): Guest Log: This vm does not need to setup http proxy

2019-07-21 05:36:44 (10612): Guest Log: core_number=1

2019-07-21 05:36:44 (10612): Guest Log: Starting ATLAS job. (Binary file (standard input) matches Binary file (standard input) matches)

2019-07-21 07:03:20 (10612): VM state change detected. (old = 'running', new = 'paused')
2019-07-21 07:06:00 (10612): VM state change detected. (old = 'paused', new = 'running')
2019-07-21 07:17:52 (10612): Status Report: Elapsed Time: '6002.628912'
2019-07-21 07:17:52 (10612): Status Report: CPU Time: '5475.015625'
2019-07-21 08:57:52 (10612): Status Report: Elapsed Time: '12003.469992'
2019-07-21 08:57:52 (10612): Status Report: CPU Time: '11160.015625'
2019-07-21 10:37:54 (10612): Status Report: Elapsed Time: '18005.560505'
2019-07-21 10:37:54 (10612): Status Report: CPU Time: '17005.640625'
2019-07-21 12:17:57 (10612): Status Report: Elapsed Time: '24008.118216'
2019-07-21 12:17:57 (10612): Status Report: CPU Time: '22825.687500'
2019-07-21 13:40:16 (10612): VM state change detected. (old = 'running', new = 'paused')
2019-07-21 13:43:16 (10612): VM state change detected. (old = 'paused', new = 'running')
2019-07-21 14:01:03 (10612): Status Report: Elapsed Time: '30008.650969'
2019-07-21 14:01:03 (10612): Status Report: CPU Time: '28716.687500'
2019-07-21 15:41:05 (10612): Status Report: Elapsed Time: '36010.641020'
2019-07-21 15:41:05 (10612): Status Report: CPU Time: '34671.828125'
2019-07-21 17:21:07 (10612): Status Report: Elapsed Time: '42012.927578'
2019-07-21 17:21:07 (10612): Status Report: CPU Time: '40656.343750'
2019-07-21 18:40:15 (10612): VM state change detected. (old = 'running', new = 'paused')
2019-07-21 18:40:20 (10612): VM state change detected. (old = 'paused', new = 'running')
2019-07-21 19:01:23 (10612): Status Report: Elapsed Time: '48014.732311'
2019-07-21 19:01:23 (10612): Status Report: CPU Time: '46608.718750'
2019-07-21 20:41:23 (10612): Status Report: Elapsed Time: '54015.165686'
2019-07-21 20:41:23 (10612): Status Report: CPU Time: '52576.906250'
2019-07-21 22:21:25 (10612): Status Report: Elapsed Time: '60016.771442'
2019-07-21 22:21:25 (10612): Status Report: CPU Time: '58533.437500'
2019-07-22 00:01:26 (10612): Status Report: Elapsed Time: '66018.068014'
2019-07-22 00:01:26 (10612): Status Report: CPU Time: '64457.984375'
2019-07-22 00:38:06 (10612): VM state change detected. (old = 'running', new = 'paused')
2019-07-22 01:26:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2019-07-22 01:27:33 (10612): VM state change detected. (old = 'running', new = 'paused')
2019-07-22 01:32:27 (10612): VM state change detected. (old = 'paused', new = 'running')
2019-07-22 02:34:55 (10612): Status Report: Elapsed Time: '72019.853243'
2019-07-22 02:34:55 (10612): Status Report: CPU Time: '70399.625000'
2019-07-22 04:14:56 (10612): Status Report: Elapsed Time: '78021.314648'
2019-07-22 04:14:56 (10612): Status Report: CPU Time: '76294.812500'
2019-07-22 05:01:10 (10612): Guest Log: The last 10 lines of the pilot log.

2019-07-22 05:01:10 (10612): Guest Log: -rw-------  1 atlas01 atlas01 11357 Jun  3 19:18 LICENSE

2019-07-22 05:01:10 (10612): Guest Log: drwx------ 14 atlas01 atlas01  4096 Jul 21 12:38 pilot

2019-07-22 05:01:10 (10612): Guest Log: -rwx------  1 atlas01 atlas01 21428 Jul 11 17:38 pilot.py

2019-07-22 05:01:10 (10612): Guest Log: -rw-------  1 atlas01 atlas01     8 Jul 17 19:00 PILOTVERSION

2019-07-22 05:01:10 (10612): Guest Log: -rw-------  1 atlas01 atlas01  2251 Jun  3 19:18 README.md

2019-07-22 05:01:10 (10612): Guest Log: -rw-------  1 atlas01 atlas01   221 Jun  3 19:18 TODO.md

2019-07-22 05:01:10 (10612): Guest Log: 2019-07-22 09:56:23 UTC [wrapper] Test setup, not cleaning

2019-07-22 05:01:10 (10612): Guest Log: 2019-07-22 09:56:23 UTC [wrapper] ==== wrapper stdout END ====

2019-07-22 05:01:10 (10612): Guest Log: 2019-07-22 09:56:23 UTC [wrapper] ==== wrapper stderr END ====

2019-07-22 05:01:10 (10612): Guest Log: Listing of results directory

2019-07-22 05:01:10 (10612): Guest Log: total 514240

2019-07-22 05:01:10 (10612): Guest Log: drwx------ 5 atlas01 atlas01      4096 Jul 17 19:00 pilot2

2019-07-22 05:01:10 (10612): Guest Log: -rw-r--r-- 1 atlas01 atlas01   4118444 Jul 20 14:29 pilot2.tar.gz

2019-07-22 05:01:10 (10612): Guest Log: -rw-r--r-- 1 atlas01 atlas01      4468 Jul 21 10:55 queuedata.json

2019-07-22 05:01:10 (10612): Guest Log: -rwx------ 1 atlas01 atlas01     15232 Jul 21 10:56 runpilot2-wrapper.sh

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01      2871 Jul 21 10:56 pandaJobData.out

2019-07-22 05:01:10 (10612): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 381485311 Jul 21 12:36 EVNT.17323813._000326.pool.root.1

2019-07-22 05:01:10 (10612): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8653 Jul 21 12:36 init_data.xml

2019-07-22 05:01:10 (10612): Guest Log: -rwxr-xr-x 1 atlas01 atlas01   4128163 Jul 21 12:36 input.tar.gz

2019-07-22 05:01:10 (10612): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       815 Jul 21 12:36 RTE.tar.gz

2019-07-22 05:01:10 (10612): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8659 Jul 21 12:36 start_atlas.sh

2019-07-22 05:01:10 (10612): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Jul 21 12:36 APPS

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01   4637549 Jul 21 12:38 agis_schedconf.cvmfs.json

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01   7368078 Jul 21 12:38 agis_ddmendpoints.json

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01 109274591 Jul 22 11:53 HITS.18604976._015642.pool.root.1

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01    404223 Jul 22 11:55 log.18604976._015642.job.log.tgz.1

2019-07-22 05:01:10 (10612): Guest Log: drwxrwx--- 2 atlas01 atlas01      4096 Jul 22 11:55 PanDA_Pilot-4422915557

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01     74098 Jul 22 11:55 heartbeat.json

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01   3605584 Jul 22 11:56 pilotlog.txt

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01   3622306 Jul 22 11:56 log.18604976._015642.job.log.1

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01       504 Jul 22 11:56 1EINDmooM9unShfckohDCDFpABFKDmABFKDmQWcbDmABFKDmCtSqHn.diag

2019-07-22 05:01:10 (10612): Guest Log: -rw-r--r-- 1 atlas01 atlas01      6799 Jul 22 11:56 runtime_log.err

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01       391 Jul 22 11:56 output.list

2019-07-22 05:01:10 (10612): Guest Log: -rw-r--r-- 1 atlas01 atlas01       692 Jul 22 11:56 runtime_log

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01   7731200 Jul 22 11:56 result.tar.gz

2019-07-22 05:01:10 (10612): Guest Log: HITS file was successfully produced

2019-07-22 05:01:10 (10612): Guest Log: -rw------- 1 atlas01 atlas01 109274591 Jul 22 11:53 /home/atlas01/RunAtlas/HITS.18604976._015642.pool.root.1

2019-07-22 05:01:10 (10612): Guest Log: Successfully finished the ATLAS job!

2019-07-22 05:01:10 (10612): Guest Log: Copying the results back to the shared directory!

2019-07-22 05:01:10 (10612): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-07-22 05:01:10 (10612): Guest Log: Success! Shutting down the machine.

2019-07-22 05:01:10 (10612): VM Completion File Detected.
2019-07-22 05:01:10 (10612): Powering off VM.
2019-07-22 05:01:12 (10612): Successfully stopped VM.
2019-07-22 05:01:17 (10612): Deregistering VM. (boinc_06e7ebbb0e042487, slot#29)
2019-07-22 05:01:17 (10612): Removing virtual disk drive(s) from VM.
2019-07-22 05:01:17 (10612): Removing network bandwidth throttle group from VM.
2019-07-22 05:01:17 (10612): Removing storage controller(s) from VM.
2019-07-22 05:01:17 (10612): Removing VM from VirtualBox.
05:01:22 (10612): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN