Stderr output

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

2019-07-09 21:13:23 (1336): Guest Log: CPUID EDX: 0x178bfbff

2019-07-09 21:13:23 (1336): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-09 21:13:23 (1336): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-09 21:13:23 (1336): Guest Log: BIOS: Booting from Hard Disk...

2019-07-09 21:13:23 (1336): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-09 21:13:23 (1336): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

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

2019-07-09 21:14:03 (1336): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae64a210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-09 21:14:03 (1336): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae7e7210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-09 21:14:03 (1336): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae7e7610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-09 21:14:03 (1336): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801b0746e10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-09 21:15:18 (1336): Guest Log: Copying input files into RunAtlas.

2019-07-09 21:15:23 (1336): Guest Log: Copied input files into RunAtlas.

2019-07-09 21:15:53 (1336): Guest Log: copied the webapp to /var/www

2019-07-09 21:15:53 (1336): Guest Log: This vm does not need to setup http proxy

2019-07-09 21:15:53 (1336): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-09 21:15:53 (1336): Guest Log: Starting ATLAS job. (PandaID=4410947772 taskID=18514527)

2019-07-09 22:53:40 (1336): Status Report: Elapsed Time: '6002.283543'
2019-07-09 22:53:40 (1336): Status Report: CPU Time: '20810.437500'
2019-07-09 23:14:33 (1336): Stopping VM.
2019-07-09 23:15:13 (1336): Successfully stopped VM.
2019-07-09 23:33:41 (1152): vboxwrapper (7.9.26200): starting
2019-07-09 23:33:42 (1152): Feature: Checkpoint interval offset (69 seconds)
2019-07-09 23:33:42 (1152): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-09 23:33:42 (1152): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-09 23:33:42 (1152): Guest Log: BIOS: VirtualBox 5.2.8

2019-07-09 23:33:42 (1152): Guest Log: CPUID EDX: 0x178bfbff

2019-07-09 23:33:42 (1152): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-09 23:33:42 (1152): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-09 23:33:42 (1152): Guest Log: BIOS: Booting from Hard Disk...

2019-07-09 23:33:42 (1152): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-09 23:33:42 (1152): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-07-09 23:33:42 (1152): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-07-09 23:33:42 (1152): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae64a210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-09 23:33:42 (1152): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae7e7210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-09 23:33:42 (1152): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae7e7610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-09 23:33:42 (1152): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801b0746e10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-09 23:33:42 (1152): Guest Log: Copying input files into RunAtlas.

2019-07-09 23:33:42 (1152): Guest Log: Copied input files into RunAtlas.

2019-07-09 23:33:42 (1152): Guest Log: copied the webapp to /var/www

2019-07-09 23:33:42 (1152): Guest Log: This vm does not need to setup http proxy

2019-07-09 23:33:42 (1152): Guest Log: ATHENA_PROC_NUMBER=4

2019-07-09 23:33:42 (1152): Guest Log: Starting ATLAS job. (PandaID=4410947772 taskID=18514527)

2019-07-09 23:33:42 (1152): Starting VM. (boinc_060797a3ca01777b, slot#4)
2019-07-09 23:34:08 (1152): Successfully started VM. (PID = '7080')
2019-07-09 23:34:08 (1152): Reporting VM Process ID to BOINC.
2019-07-09 23:34:13 (1152): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-09 23:34:18 (1152): Detected: Web Application Enabled (http://localhost:58064)
2019-07-09 23:34:23 (1152): Status Report: Elapsed Time: '7255.017479'
2019-07-09 23:34:23 (1152): Status Report: CPU Time: '25797.203125'
2019-07-09 23:34:23 (1152): Preference change detected
2019-07-09 23:34:23 (1152): Setting CPU throttle for VM. (100%)
2019-07-09 23:34:23 (1152): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-10 01:14:27 (1152): Status Report: Elapsed Time: '13258.872770'
2019-07-10 01:14:27 (1152): Status Report: CPU Time: '49643.687500'
2019-07-10 01:35:10 (1152): Stopping VM.
2019-07-10 01:35:46 (1152): Successfully stopped VM.
2019-07-10 01:52:53 (2716): vboxwrapper (7.9.26200): starting
2019-07-10 01:52:53 (2716): Feature: Checkpoint interval offset (163 seconds)
2019-07-10 01:52:53 (2716): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-10 01:52:53 (2716): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-10 01:52:53 (2716): Starting VM. (boinc_060797a3ca01777b, slot#4)
2019-07-10 01:53:22 (2716): Successfully started VM. (PID = '4968')
2019-07-10 01:53:22 (2716): Reporting VM Process ID to BOINC.
2019-07-10 01:53:27 (2716): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-10 01:53:32 (2716): Detected: Web Application Enabled (http://localhost:58064)
2019-07-10 01:53:37 (2716): Status Report: Elapsed Time: '14501.430855'
2019-07-10 01:53:37 (2716): Status Report: CPU Time: '54634.250000'
2019-07-10 01:53:37 (2716): Preference change detected
2019-07-10 01:53:37 (2716): Setting CPU throttle for VM. (100%)
2019-07-10 01:53:37 (2716): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-10 03:33:40 (2716): Status Report: Elapsed Time: '20504.849188'
2019-07-10 03:33:40 (2716): Status Report: CPU Time: '78480.312500'
2019-07-10 03:54:18 (2716): Stopping VM.
2019-07-10 03:54:54 (2716): Successfully stopped VM.
2019-07-10 04:13:05 (8156): vboxwrapper (7.9.26200): starting
2019-07-10 04:13:05 (8156): Feature: Checkpoint interval offset (488 seconds)
2019-07-10 04:13:05 (8156): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-07-10 04:13:05 (8156): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-10 04:13:05 (8156): Starting VM. (boinc_060797a3ca01777b, slot#4)
2019-07-10 04:13:34 (8156): Successfully started VM. (PID = '5200')
2019-07-10 04:13:34 (8156): Reporting VM Process ID to BOINC.
2019-07-10 04:13:39 (8156): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-10 04:13:44 (8156): Detected: Web Application Enabled (http://localhost:58064)
2019-07-10 04:13:49 (8156): Status Report: Elapsed Time: '21742.905045'
2019-07-10 04:13:49 (8156): Status Report: CPU Time: '83474.859375'
2019-07-10 04:13:49 (8156): Preference change detected
2019-07-10 04:13:49 (8156): Setting CPU throttle for VM. (100%)
2019-07-10 04:13:49 (8156): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-10 05:28:23 (8156): Guest Log: The last 10 lines of the pilot log.

2019-07-10 05:28:23 (8156): Guest Log: -rw-------  1 atlas01 atlas01 11357 Jun  3 19:18 LICENSE

2019-07-10 05:28:23 (8156): Guest Log: drwx------ 14 atlas01 atlas01  4096 Jul  9 21:17 pilot

2019-07-10 05:28:23 (8156): Guest Log: -rwx------  1 atlas01 atlas01 21401 Jun 19 12:31 pilot.py

2019-07-10 05:28:23 (8156): Guest Log: -rw-------  1 atlas01 atlas01     9 Jun 27 00:30 PILOTVERSION

2019-07-10 05:28:23 (8156): Guest Log: -rw-------  1 atlas01 atlas01  2251 Jun  3 19:18 README.md

2019-07-10 05:28:23 (8156): Guest Log: -rw-------  1 atlas01 atlas01   221 Jun  3 19:18 TODO.md

2019-07-10 05:28:23 (8156): Guest Log: 2019-07-10 03:28:21 UTC [wrapper] Test setup, not cleaning

2019-07-10 05:28:23 (8156): Guest Log: 2019-07-10 03:28:21 UTC [wrapper] ==== wrapper stdout END ====

2019-07-10 05:28:23 (8156): Guest Log: 2019-07-10 03:28:21 UTC [wrapper] ==== wrapper stderr END ====

2019-07-10 05:28:23 (8156): Guest Log: Listing of results directory

2019-07-10 05:28:23 (8156): Guest Log: total 504304

2019-07-10 05:28:23 (8156): Guest Log: drwx------ 5 atlas01 atlas01      4096 Jun 27 00:30 pilot2

2019-07-10 05:28:23 (8156): Guest Log: -rw-r--r-- 1 atlas01 atlas01   3736999 Jul  8 13:17 pilot2.tar.gz

2019-07-10 05:28:23 (8156): Guest Log: -rwx------ 1 atlas01 atlas01     15232 Jul  9 21:09 runpilot2-wrapper.sh

2019-07-10 05:28:23 (8156): Guest Log: -rw-r--r-- 1 atlas01 atlas01      4468 Jul  9 21:09 queuedata.json

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01      2873 Jul  9 21:09 pandaJobData.out

2019-07-10 05:28:23 (8156): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 376445965 Jul  9 21:15 EVNT.17323636._000447.pool.root.1

2019-07-10 05:28:23 (8156): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8728 Jul  9 21:15 init_data.xml

2019-07-10 05:28:23 (8156): Guest Log: -rwxr-xr-x 1 atlas01 atlas01   3745770 Jul  9 21:15 input.tar.gz

2019-07-10 05:28:23 (8156): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       815 Jul  9 21:15 RTE.tar.gz

2019-07-10 05:28:23 (8156): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8659 Jul  9 21:15 start_atlas.sh

2019-07-10 05:28:23 (8156): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Jul  9 21:15 APPS

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01   4644341 Jul  9 21:17 agis_schedconf.cvmfs.json

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01   7328357 Jul  9 21:17 agis_ddmendpoints.json

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01 113448361 Jul 10 05:25 HITS.18514527._020945.pool.root.1

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01       306 Jul 10 05:25 memory_monitor_summary.json

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01    862060 Jul 10 05:26 log.18514527._020945.job.log.tgz.1

2019-07-10 05:28:23 (8156): Guest Log: drwxrwx--- 3 atlas01 atlas01      4096 Jul 10 05:27 PanDA_Pilot-4410947772

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01     76289 Jul 10 05:27 heartbeat.json

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01   1248476 Jul 10 05:28 pilotlog.txt

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01   1265053 Jul 10 05:28 log.18514527._020945.job.log.1

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01       512 Jul 10 05:28 8OzKDmQfA5unShfckohDCDFpABFKDmABFKDmdEOUDmABFKDmQ4P7Fm.diag

2019-07-10 05:28:23 (8156): Guest Log: -rw-r--r-- 1 atlas01 atlas01      6809 Jul 10 05:28 runtime_log.err

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01       391 Jul 10 05:28 output.list

2019-07-10 05:28:23 (8156): Guest Log: -rw-r--r-- 1 atlas01 atlas01       692 Jul 10 05:28 runtime_log

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01   3481600 Jul 10 05:28 result.tar.gz

2019-07-10 05:28:23 (8156): Guest Log: HITS file was successfully produced

2019-07-10 05:28:23 (8156): Guest Log: -rw------- 1 atlas01 atlas01 113448361 Jul 10 05:25 /home/atlas01/RunAtlas/HITS.18514527._020945.pool.root.1

2019-07-10 05:28:23 (8156): Guest Log: Successfully finished the ATLAS job!

2019-07-10 05:28:23 (8156): Guest Log: Copying the results back to the shared directory!

2019-07-10 05:28:23 (8156): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-07-10 05:28:23 (8156): Guest Log: Success! Shutting down the machine.

2019-07-10 05:28:23 (8156): VM Completion File Detected.
2019-07-10 05:28:23 (8156): Powering off VM.
2019-07-10 05:28:25 (8156): Successfully stopped VM.
2019-07-10 05:28:30 (8156): Deregistering VM. (boinc_060797a3ca01777b, slot#4)
2019-07-10 05:28:30 (8156): Removing virtual disk drive(s) from VM.
2019-07-10 05:28:30 (8156): Removing network bandwidth throttle group from VM.
2019-07-10 05:28:30 (8156): Removing storage controller(s) from VM.
2019-07-10 05:28:30 (8156): Removing VM from VirtualBox.
05:28:35 (8156): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN