Stderr output

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

2019-07-17 18:43:38 (23300): Guest Log: CPUID EDX: 0x178bfbff

2019-07-17 18:43:38 (23300): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-17 18:43:38 (23300): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-17 18:43:38 (23300): Guest Log: BIOS: Booting from Hard Disk...

2019-07-17 18:43:38 (23300): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-17 18:43:38 (23300): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

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

2019-07-17 18:44:18 (23300): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801aecbcc10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 18:44:18 (23300): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ab873c10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 18:44:18 (23300): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae355c10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 18:44:18 (23300): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801abba0210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 18:45:18 (23300): Guest Log: Copying input files into RunAtlas.

2019-07-17 18:45:33 (23300): Guest Log: Copied input files into RunAtlas.

2019-07-17 18:45:48 (23300): Guest Log: copied the webapp to /var/www

2019-07-17 18:45:48 (23300): Guest Log: This vm does not need to setup http proxy

2019-07-17 18:45:48 (23300): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-17 18:45:48 (23300): Guest Log: Starting ATLAS job. (PandaID=4419186495 taskID=18514514)

2019-07-17 20:23:53 (23300): Status Report: Elapsed Time: '6000.149700'
2019-07-17 20:23:53 (23300): Status Report: CPU Time: '21268.062500'
2019-07-17 20:44:51 (23300): Stopping VM.
2019-07-17 20:45:29 (23300): Successfully stopped VM.
2019-07-17 20:50:32 (23616): vboxwrapper (7.9.26200): starting
2019-07-17 20:50:32 (23616): Feature: Checkpoint interval offset (212 seconds)
2019-07-17 20:50:32 (23616): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-17 20:50:32 (23616): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-17 20:50:32 (23616): Guest Log: BIOS: VirtualBox 5.2.8

2019-07-17 20:50:32 (23616): Guest Log: CPUID EDX: 0x178bfbff

2019-07-17 20:50:32 (23616): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-17 20:50:32 (23616): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-17 20:50:32 (23616): Guest Log: BIOS: Booting from Hard Disk...

2019-07-17 20:50:32 (23616): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-17 20:50:32 (23616): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-07-17 20:50:32 (23616): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-07-17 20:50:32 (23616): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801aecbcc10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 20:50:32 (23616): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ab873c10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 20:50:32 (23616): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae355c10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 20:50:32 (23616): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801abba0210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-17 20:50:32 (23616): Guest Log: Copying input files into RunAtlas.

2019-07-17 20:50:32 (23616): Guest Log: Copied input files into RunAtlas.

2019-07-17 20:50:32 (23616): Guest Log: copied the webapp to /var/www

2019-07-17 20:50:32 (23616): Guest Log: This vm does not need to setup http proxy

2019-07-17 20:50:32 (23616): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-17 20:50:32 (23616): Guest Log: Starting ATLAS job. (PandaID=4419186495 taskID=18514514)

2019-07-17 20:50:32 (23616): Starting VM. (boinc_062db51bd1dfd2bf, slot#4)
2019-07-17 20:51:27 (23616): Successfully started VM. (PID = '25956')
2019-07-17 20:51:27 (23616): Reporting VM Process ID to BOINC.
2019-07-17 20:51:32 (23616): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-17 20:51:37 (23616): Detected: Web Application Enabled (http://localhost:52913)
2019-07-17 20:51:42 (23616): Status Report: Elapsed Time: '7257.233528'
2019-07-17 20:51:42 (23616): Status Report: CPU Time: '26268.078125'
2019-07-17 20:51:42 (23616): Preference change detected
2019-07-17 20:51:42 (23616): Setting CPU throttle for VM. (100%)
2019-07-17 20:51:42 (23616): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-17 22:31:43 (23616): Status Report: Elapsed Time: '13257.757633'
2019-07-17 22:31:43 (23616): Status Report: CPU Time: '50179.484375'
2019-07-17 22:51:55 (23616): Stopping VM.
2019-07-17 22:52:34 (23616): Successfully stopped VM.
2019-07-18 00:59:16 (21232): vboxwrapper (7.9.26200): starting
2019-07-18 00:59:16 (21232): Feature: Checkpoint interval offset (70 seconds)
2019-07-18 00:59:16 (21232): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-18 00:59:16 (21232): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-18 00:59:16 (21232): Starting VM. (boinc_062db51bd1dfd2bf, slot#4)
2019-07-18 00:59:43 (21232): Successfully started VM. (PID = '24684')
2019-07-18 00:59:43 (21232): Reporting VM Process ID to BOINC.
2019-07-18 00:59:48 (21232): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-18 00:59:53 (21232): Detected: Web Application Enabled (http://localhost:52913)
2019-07-18 00:59:58 (21232): Status Report: Elapsed Time: '14469.846445'
2019-07-18 00:59:58 (21232): Status Report: CPU Time: '55181.859375'
2019-07-18 00:59:58 (21232): Preference change detected
2019-07-18 00:59:58 (21232): Setting CPU throttle for VM. (100%)
2019-07-18 00:59:58 (21232): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-18 02:39:58 (21232): Status Report: Elapsed Time: '20470.529291'
2019-07-18 02:39:58 (21232): Status Report: CPU Time: '79060.046875'
2019-07-18 03:58:10 (21232): Guest Log: The last 10 lines of the pilot log.

2019-07-18 03:58:10 (21232): Guest Log: -rw-------  1 atlas01 atlas01 11357 Jun  3 19:18 LICENSE

2019-07-18 03:58:10 (21232): Guest Log: drwx------ 14 atlas01 atlas01  4096 Jul 17 18:46 pilot

2019-07-18 03:58:10 (21232): Guest Log: -rwx------  1 atlas01 atlas01 21428 Jul 11 17:38 pilot.py

2019-07-18 03:58:10 (21232): Guest Log: -rw-------  1 atlas01 atlas01     8 Jul 15 15:01 PILOTVERSION

2019-07-18 03:58:10 (21232): Guest Log: -rw-------  1 atlas01 atlas01  2251 Jun  3 19:18 README.md

2019-07-18 03:58:10 (21232): Guest Log: -rw-------  1 atlas01 atlas01   221 Jun  3 19:18 TODO.md

2019-07-18 03:58:10 (21232): Guest Log: 2019-07-18 01:58:07 UTC [wrapper] Test setup, not cleaning

2019-07-18 03:58:10 (21232): Guest Log: 2019-07-18 01:58:07 UTC [wrapper] ==== wrapper stdout END ====

2019-07-18 03:58:10 (21232): Guest Log: 2019-07-18 01:58:07 UTC [wrapper] ==== wrapper stderr END ====

2019-07-18 03:58:10 (21232): Guest Log: Listing of results directory

2019-07-18 03:58:10 (21232): Guest Log: total 495680

2019-07-18 03:58:10 (21232): Guest Log: drwx------ 5 atlas01 atlas01      4096 Jul 15 15:01 pilot2

2019-07-18 03:58:10 (21232): Guest Log: -rw-r--r-- 1 atlas01 atlas01   4056709 Jul 16 15:21 pilot2.tar.gz

2019-07-18 03:58:10 (21232): Guest Log: -rw-r--r-- 1 atlas01 atlas01      4468 Jul 17 17:10 queuedata.json

2019-07-18 03:58:10 (21232): Guest Log: -rwx------ 1 atlas01 atlas01     15232 Jul 17 17:13 runpilot2-wrapper.sh

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01      2870 Jul 17 17:13 pandaJobData.out

2019-07-18 03:58:10 (21232): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 376952381 Jul 17 18:45 EVNT.17323631._000908.pool.root.1

2019-07-18 03:58:10 (21232): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8727 Jul 17 18:45 init_data.xml

2019-07-18 03:58:10 (21232): Guest Log: -rwxr-xr-x 1 atlas01 atlas01   4066484 Jul 17 18:45 input.tar.gz

2019-07-18 03:58:10 (21232): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       815 Jul 17 18:45 RTE.tar.gz

2019-07-18 03:58:10 (21232): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8659 Jul 17 18:45 start_atlas.sh

2019-07-18 03:58:10 (21232): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Jul 17 18:45 APPS

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01   4659947 Jul 17 18:46 agis_schedconf.cvmfs.json

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01   7348295 Jul 17 18:46 agis_ddmendpoints.json

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01 103502867 Jul 18 03:54 HITS.18514514._046528.pool.root.1

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01    843064 Jul 18 03:57 log.18514514._046528.job.log.tgz.1

2019-07-18 03:58:10 (21232): Guest Log: drwxrwx--- 3 atlas01 atlas01      4096 Jul 18 03:57 PanDA_Pilot-4419186495

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01     74401 Jul 18 03:57 heartbeat.json

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01   1241746 Jul 18 03:58 pilotlog.txt

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01   1258323 Jul 18 03:58 log.18514514._046528.job.log.1

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01       512 Jul 18 03:58 ipYLDm0n07unShfckohDCDFpABFKDmABFKDmSSPZDmABFKDmEf4H8n.diag

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01       391 Jul 18 03:58 output.list

2019-07-18 03:58:10 (21232): Guest Log: -rw-r--r-- 1 atlas01 atlas01      6829 Jul 18 03:58 runtime_log.err

2019-07-18 03:58:10 (21232): Guest Log: -rw-r--r-- 1 atlas01 atlas01       692 Jul 18 03:58 runtime_log

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01   3440640 Jul 18 03:58 result.tar.gz

2019-07-18 03:58:10 (21232): Guest Log: HITS file was successfully produced

2019-07-18 03:58:10 (21232): Guest Log: -rw------- 1 atlas01 atlas01 103502867 Jul 18 03:54 /home/atlas01/RunAtlas/HITS.18514514._046528.pool.root.1

2019-07-18 03:58:10 (21232): Guest Log: Successfully finished the ATLAS job!

2019-07-18 03:58:10 (21232): Guest Log: Copying the results back to the shared directory!

2019-07-18 03:58:10 (21232): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-07-18 03:58:10 (21232): Guest Log: Success! Shutting down the machine.

2019-07-18 03:58:10 (21232): VM Completion File Detected.
2019-07-18 03:58:10 (21232): Powering off VM.
2019-07-18 03:58:13 (21232): Successfully stopped VM.
2019-07-18 03:58:18 (21232): Deregistering VM. (boinc_062db51bd1dfd2bf, slot#4)
2019-07-18 03:58:18 (21232): Removing virtual disk drive(s) from VM.
2019-07-18 03:58:18 (21232): Removing network bandwidth throttle group from VM.
2019-07-18 03:58:18 (21232): Removing storage controller(s) from VM.
2019-07-18 03:58:18 (21232): Removing VM from VirtualBox.
03:58:23 (21232): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN