Stderr output

<core_client_version>7.16.20</core_client_version>
<![CDATA[
<stderr_txt>
2022-01-18 22:01:37 (1104): Detected: vboxwrapper 26202
2022-01-18 22:01:37 (1104): Detected: BOINC client v7.16.20
2022-01-18 22:01:37 (1104): Detected: VirtualBox VboxManage Interface (Version: 6.1.16)
2022-01-18 22:01:37 (1104): Successfully copied 'init_data.xml' to the shared directory.
2022-01-18 22:01:39 (1104): Create VM. (boinc_f806cfc34499c424, slot#14)
2022-01-18 22:01:40 (1104): Setting Memory Size for VM. (3900MB)
2022-01-18 22:01:41 (1104): Setting CPU Count for VM. (1)
2022-01-18 22:01:41 (1104): Setting Chipset Options for VM.
2022-01-18 22:01:42 (1104): Setting Boot Options for VM.
2022-01-18 22:01:43 (1104): Setting Network Configuration for NAT.
2022-01-18 22:01:43 (1104): Enabling VM Network Access.
2022-01-18 22:01:43 (1104): Disabling USB Support for VM.
2022-01-18 22:01:43 (1104): Disabling COM Port Support for VM.
2022-01-18 22:01:44 (1104): Disabling LPT Port Support for VM.
2022-01-18 22:01:44 (1104): Disabling Audio Support for VM.
2022-01-18 22:01:44 (1104): Disabling Clipboard Support for VM.
2022-01-18 22:01:45 (1104): Disabling Drag and Drop Support for VM.
2022-01-18 22:01:45 (1104): Adding storage controller(s) to VM.
2022-01-18 22:01:45 (1104): Adding virtual disk drive to VM. (vm_image.vdi)
2022-01-18 22:01:46 (1104): Adding VirtualBox Guest Additions to VM.
2022-01-18 22:01:46 (1104): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2022-01-18 22:01:46 (1104): forwarding host port 52618 to guest port 80
2022-01-18 22:01:47 (1104): Enabling remote desktop for VM.
2022-01-18 22:01:48 (1104): Enabling shared directory for VM.
2022-01-18 22:01:49 (1104): Starting VM using VBoxManage interface. (boinc_f806cfc34499c424, slot#14)
2022-01-18 22:01:59 (1104): Successfully started VM. (PID = '13632')
2022-01-18 22:01:59 (1104): Reporting VM Process ID to BOINC.
2022-01-18 22:01:59 (1104): Guest Log: BIOS: VirtualBox 6.1.16
2022-01-18 22:01:59 (1104): Guest Log: CPUID EDX: 0x178bfbff
2022-01-18 22:01:59 (1104): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2022-01-18 22:01:59 (1104): VM state change detected. (old = 'poweredoff', new = 'running')
2022-01-18 22:01:59 (1104): Detected: Web Application Enabled (http://localhost:52618)
2022-01-18 22:01:59 (1104): Detected: Remote Desktop Enabled (localhost:52627)
2022-01-18 22:01:59 (1104): Preference change detected
2022-01-18 22:01:59 (1104): Setting CPU throttle for VM. (100%)
2022-01-18 22:01:59 (1104): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2022-01-18 22:02:02 (1104): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-01-18 22:02:02 (1104): Guest Log: BIOS: Booting from Hard Disk...
2022-01-18 22:02:04 (1104): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-01-18 22:02:04 (1104): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2022-01-18 22:02:04 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2022-01-18 22:02:05 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2022-01-18 22:02:05 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2022-01-18 22:02:05 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2022-01-18 22:02:05 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2022-01-18 22:02:05 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2022-01-18 22:02:05 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2022-01-18 22:02:05 (1104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2022-01-18 22:02:05 (1104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2022-01-18 22:02:11 (1104): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-01-18 22:02:11 (1104): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-01-18 22:02:14 (1104): VM state change detected. (old = 'running', new = 'paused')
2022-01-18 22:02:24 (1104): VM state change detected. (old = 'paused', new = 'running')
2022-01-18 22:02:29 (1104): Guest Log: Checking CVMFS...
2022-01-18 22:02:34 (1104): VM state change detected. (old = 'running', new = 'paused')
2022-01-18 22:02:44 (1104): VM state change detected. (old = 'paused', new = 'running')
2022-01-18 22:02:54 (1104): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2022-01-18 22:02:54 (1104): Guest Log: 00:00:00.000351 main     Log opened 2022-01-18T22:02:33.741033000Z
2022-01-18 22:02:54 (1104): Guest Log: 00:00:00.000552 main     OS Product: Linux
2022-01-18 22:02:54 (1104): Guest Log: 00:00:00.000626 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2022-01-18 22:02:54 (1104): Guest Log: 00:00:00.000715 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2022-01-18 22:02:54 (1104): Guest Log: 00:00:00.000767 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2022-01-18 22:02:54 (1104): Guest Log: 00:00:00.000770 main     Process ID: 1591
2022-01-18 22:02:54 (1104): Guest Log: 00:00:00.000771 main     Package type: LINUX_64BITS_GENERIC
2022-01-18 22:02:54 (1104): Guest Log: 00:00:00.006546 main     5.2.32 r132073 started. Verbose level = 0
2022-01-18 22:02:58 (1104): Guest Log: CVMFS is ok
2022-01-18 22:02:59 (1104): Guest Log: Mounting shared directory
2022-01-18 22:02:59 (1104): Guest Log: Copying input files
2022-01-18 22:03:01 (1104): Guest Log: Copied input files into RunAtlas.
2022-01-18 22:03:04 (1104): Guest Log: 00:00:10.722037 timesync vgsvcTimeSyncWorker: Radical guest time change: 21 630 524 139 000ns (GuestNow=1 642 564 984 337 397 000 ns GuestLast=1 642 543 353 813 258 000 ns fSetTimeLastLoop=true )
2022-01-18 22:03:05 (1104): Guest Log: copied the webapp to /var/www
2022-01-18 22:03:05 (1104): Guest Log: This vm does not need to setup an http proxy
2022-01-18 22:03:05 (1104): Guest Log: core_number=1
2022-01-18 22:03:06 (1104): Guest Log:  *** Starting ATLAS job. (PandaID=5331649545 taskID=NULL&cor) ***
2022-01-18 22:17:34 (1104): VM state change detected. (old = 'running', new = 'paused')
2022-01-18 22:17:45 (1104): VM state change detected. (old = 'paused', new = 'running')
2022-01-18 22:27:34 (1104): VM state change detected. (old = 'running', new = 'paused')
2022-01-18 22:27:44 (1104): VM state change detected. (old = 'paused', new = 'running')
2022-01-18 22:32:38 (1104): VM state change detected. (old = 'running', new = 'paused')
2022-01-18 22:32:56 (1104): VM state change detected. (old = 'paused', new = 'running')
2022-01-18 22:37:31 (1104): VM state change detected. (old = 'running', new = 'paused')
2022-01-18 22:37:42 (1104): VM state change detected. (old = 'paused', new = 'running')
2022-01-18 22:42:34 (1104): VM state change detected. (old = 'running', new = 'paused')
2022-01-18 22:42:47 (1104): VM state change detected. (old = 'paused', new = 'running')
2022-01-18 22:47:36 (1104): VM state change detected. (old = 'running', new = 'paused')
2022-01-18 22:47:47 (1104): VM state change detected. (old = 'paused', new = 'running')
2022-01-18 22:52:15 (1104): Guest Log:  *** Job finished ***
2022-01-18 22:52:15 (1104): Guest Log:  *** The last 20 lines of the pilot log: ***
2022-01-18 22:52:15 (1104): Guest Log:  *** Error codes and diagnostics ***
2022-01-18 22:52:20 (1104): Guest Log:     "exeErrorCode": 0,
2022-01-18 22:52:20 (1104): Guest Log:     "exeErrorDiag": "",
2022-01-18 22:52:20 (1104): Guest Log:     "pilotErrorCode": 0,
2022-01-18 22:52:20 (1104): Guest Log:     "pilotErrorDiag": "",
2022-01-18 22:52:20 (1104): Guest Log:  *** Listing of results directory ***
2022-01-18 22:52:20 (1104): Guest Log: total 8068
2022-01-18 22:52:20 (1104): Guest Log: -rw-r--r--. 1 atlas atlas  344354 Jan 19 03:35 pilot2.tar.gz
2022-01-18 22:52:20 (1104): Guest Log: -rwx------. 1 atlas atlas   26862 Jan 19 03:57 runpilot2-wrapper.sh
2022-01-18 22:52:20 (1104): Guest Log: -rw-r--r--. 1 atlas atlas    4534 Jan 19 03:57 queuedata.json
2022-01-18 22:52:20 (1104): Guest Log: -rwxr-xr-x. 1 atlas atlas    8883 Jan 19 04:03 init_data.xml
2022-01-18 22:52:20 (1104): Guest Log: -rwxr-xr-x. 1 atlas atlas  356142 Jan 19 04:03 input.tar.gz
2022-01-18 22:52:20 (1104): Guest Log: -rwxr-xr-x. 1 atlas atlas   16583 Jan 19 04:03 start_atlas.sh
2022-01-18 22:52:20 (1104): Guest Log: lrwxrwxrwx. 1 atlas atlas      20 Jan 19 04:03 EVNT.04972714._000036.pool.root.1 -> /data/./ATLAS.root_0
2022-01-18 22:52:20 (1104): Guest Log: -rw-r--r--. 1 atlas atlas    2616 Jan 19 04:03 pandaJob.out
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas 1097804 Jan 19 04:03 agis_schedconf.cvmfs.json
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas 1926759 Jan 19 04:03 cric_ddmendpoints.json
2022-01-18 22:52:20 (1104): Guest Log: drwx------. 4 atlas atlas     260 Jan 19 04:03 pilot2
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas 1876308 Jan 19 04:50 output.1.1b097ecc-ec35-4049-a631-127965d793be_34732.pool.root
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas    1018 Jan 19 04:50 memory_monitor_summary.json
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas  168508 Jan 19 04:50 1b097ecc-ec35-4049-a631-127965d793be_34732.1.job.log.tgz
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas    8056 Jan 19 04:51 heartbeat.json
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas    1622 Jan 19 04:51 pilotlog.txt
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas  144299 Jan 19 04:51 1b097ecc-ec35-4049-a631-127965d793be_34732.1.job.log
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas     536 Jan 19 04:51 output.list
2022-01-18 22:52:20 (1104): Guest Log: -rw-r--r--. 1 atlas atlas     748 Jan 19 04:51 runtime_log
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas 2211840 Jan 19 04:51 result.tar.gz
2022-01-18 22:52:20 (1104): Guest Log: -rw-r--r--. 1 atlas atlas    9306 Jan 19 04:51 runtime_log.err
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas     563 Jan 19 04:51 lP8NDmYHHU0n7Olcko1bjSoqABFKDmABFKDm1XmMDmieGKDmOlXfom.diag
2022-01-18 22:52:20 (1104): Guest Log: Looking for outputfile output.1.1b097ecc-ec35-4049-a631-127965d793be_34732.pool.root
2022-01-18 22:52:20 (1104): Guest Log: HITS file was successfully produced
2022-01-18 22:52:20 (1104): Guest Log: -rw-------. 1 atlas atlas 1876308 Jan 19 04:50 /home/atlas/RunAtlas/output.1.1b097ecc-ec35-4049-a631-127965d793be_34732.pool.root
2022-01-18 22:52:25 (1104): Guest Log: Successfully finished the ATLAS job!
2022-01-18 22:52:25 (1104): Guest Log: Copying the results back to the shared directory!
2022-01-18 22:52:25 (1104): Guest Log:  *** Contents of shared directory: ***
2022-01-18 22:52:25 (1104): Guest Log: total 42176
2022-01-18 22:52:25 (1104): Guest Log: -rwxrwxrwx. 1 root root 38705932 Jan 19 04:01 ATLAS.root_0
2022-01-18 22:52:25 (1104): Guest Log: -rwxrwxrwx. 1 root root  1876308 Jan 19 04:50 HITS.pool.root.1
2022-01-18 22:52:25 (1104): Guest Log: -rwxrwxrwx. 1 root root     8883 Jan 19 04:01 init_data.xml
2022-01-18 22:52:25 (1104): Guest Log: -rwxrwxrwx. 1 root root   356142 Jan 19 04:00 input.tar.gz
2022-01-18 22:52:25 (1104): Guest Log: -rwxrwxrwx. 1 root root  2211840 Jan 19  2022 result.tar.gz
2022-01-18 22:52:25 (1104): Guest Log: -rwxrwxrwx. 1 root root    16583 Jan 19 04:00 start_atlas.sh
2022-01-18 22:52:25 (1104): Guest Log:  *** Success! Shutting down the machine. ***
2022-01-18 22:52:25 (1104): Guest Log: 00:48:29.128089 control  Guest control service stopped
2022-01-18 22:52:25 (1104): Guest Log: 00:48:29.128246 control  Guest control worker returned with rc=VINF_SUCCESS
2022-01-18 22:52:25 (1104): Guest Log: 00:48:29.128383 main     Session 0 is about to close ...
2022-01-18 22:52:25 (1104): Guest Log: 00:48:29.128437 main     Stopping all guest processes ...
2022-01-18 22:52:25 (1104): Guest Log: 00:48:29.128487 main     Closing all guest files ...
2022-01-18 22:52:25 (1104): Guest Log: 00:48:29.230958 main     Ended.
2022-01-18 22:52:25 (1104): VM Completion File Detected.
2022-01-18 22:52:25 (1104): Powering off VM.
2022-01-18 22:52:27 (1104): Successfully stopped VM.
2022-01-18 22:52:27 (1104): Deregistering VM. (boinc_f806cfc34499c424, slot#14)
2022-01-18 22:52:28 (1104): Removing network bandwidth throttle group from VM.
2022-01-18 22:52:29 (1104): Removing VM from VirtualBox.
22:52:38 (1104): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN