Stderr output

<core_client_version>7.22.2</core_client_version>
<![CDATA[
<stderr_txt>
2023-08-14 23:34:11 (9836): Detected: vboxwrapper 26206
2023-08-14 23:34:11 (9836): Detected: BOINC client v7.22.2
2023-08-14 23:34:12 (9836): Detected: VirtualBox VboxManage Interface (Version: 7.0.4)
2023-08-14 23:34:12 (9836): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-08-14 23:34:12 (9836): Successfully copied 'init_data.xml' to the shared directory.
2023-08-14 23:34:12 (9836): Successfully copied 'input' to the shared directory.
2023-08-14 23:34:13 (9836): Create VM. (boinc_acee8369aab38bdf, slot#5)
2023-08-14 23:34:16 (9836): Setting Memory Size for VM. (630MB)
2023-08-14 23:34:17 (9836): Setting CPU Count for VM. (1)
2023-08-14 23:34:19 (9836): Setting Chipset Options for VM.
2023-08-14 23:34:20 (9836): Setting Graphics Controller Options for VM.
2023-08-14 23:34:22 (9836): Setting Boot Options for VM.
2023-08-14 23:34:23 (9836): Setting Network Configuration for NAT.
2023-08-14 23:34:24 (9836): Enabling VM Network Access.
2023-08-14 23:34:26 (9836): Disabling USB Support for VM.
2023-08-14 23:34:26 (9836): Disabling COM Port Support for VM.
2023-08-14 23:34:31 (9836): Disabling LPT Port Support for VM.
2023-08-14 23:34:31 (9836): Disabling Audio Support for VM.
2023-08-14 23:34:32 (9836): Disabling Clipboard Support for VM.
2023-08-14 23:34:33 (9836): Disabling Drag and Drop Support for VM.
2023-08-14 23:34:33 (9836): Adding storage controller(s) to VM.
2023-08-14 23:34:35 (9836): Adding virtual disk drive to VM. (Theory_2022_07_28.vdi)
2023-08-14 23:34:38 (9836): Adding VirtualBox Guest Additions to VM.
2023-08-14 23:34:39 (9836): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-08-14 23:34:40 (9836): forwarding host port 62414 to guest port 80
2023-08-14 23:34:42 (9836): Enabling remote desktop for VM.
2023-08-14 23:34:43 (9836): Enabling shared directory for VM.
2023-08-14 23:34:44 (9836): Starting VM using VBoxManage interface. (boinc_acee8369aab38bdf, slot#5)
2023-08-14 23:34:52 (9836): Successfully started VM. (PID = '10272')
2023-08-14 23:34:52 (9836): Reporting VM Process ID to BOINC.
2023-08-14 23:34:52 (9836): Guest Log: BIOS: VirtualBox 7.0.4
2023-08-14 23:34:52 (9836): Guest Log: CPUID EDX: 0x178bfbff
2023-08-14 23:34:52 (9836): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-08-14 23:34:52 (9836): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-08-14 23:34:52 (9836): VM state change detected. (old = 'poweredoff', new = 'running')
2023-08-14 23:34:52 (9836): Detected: Web Application Enabled (http://localhost:62414)
2023-08-14 23:34:52 (9836): Detected: Remote Desktop Enabled (localhost:62419)
2023-08-14 23:34:53 (9836): VM state change detected. (old = 'running', new = 'paused')
2023-08-14 23:45:13 (9836): Preference change detected
2023-08-14 23:45:13 (9836): Setting CPU throttle for VM. (100%)
2023-08-14 23:45:13 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-14 23:45:14 (9836): VM state change detected. (old = 'paused', new = 'running')
2023-08-14 23:45:15 (9836): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-08-14 23:45:15 (9836): Guest Log: BIOS: Booting from Hard Disk...
2023-08-14 23:45:18 (9836): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-08-14 23:45:18 (9836): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-08-14 23:46:02 (9836): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-08-14 23:46:02 (9836): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-08-14 23:46:05 (9836): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-08-14 23:46:05 (9836): Guest Log: 00:00:00.000122 main     Log opened 2023-08-15T06:46:04.918655000Z
2023-08-14 23:46:05 (9836): Guest Log: 00:00:00.000232 main     OS Product: Linux
2023-08-14 23:46:05 (9836): Guest Log: 00:00:00.000270 main     OS Release: 4.14.76-13.cernvm.x86_64
2023-08-14 23:46:05 (9836): Guest Log: 00:00:00.000331 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-08-14 23:46:05 (9836): Guest Log: 00:00:00.000366 main     Executable: /usr/sbin/VBoxService
2023-08-14 23:46:05 (9836): Guest Log: 00:00:00.000367 main     Process ID: 3204
2023-08-14 23:46:05 (9836): Guest Log: 00:00:00.000368 main     Package type: LINUX_64BITS_GENERIC
2023-08-14 23:46:05 (9836): Guest Log: 00:00:00.004002 main     5.2.6 r120293 started. Verbose level = 0
2023-08-14 23:46:53 (9836): Guest Log: 08:46:52 CEST +02:00 2023-08-15: cranky: [INFO] Detected Theory App
2023-08-14 23:46:53 (9836): Guest Log: 08:46:52 CEST +02:00 2023-08-15: cranky: [INFO] Checking CVMFS.
2023-08-14 23:46:54 (9836): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-08-14 23:46:55 (9836): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2023-08-14 23:46:55 (9836): Guest Log: 2.5.2.0 4123 0 26356 26764 3 1 268678 4096000 0 65024 0 0 n/a 5 0 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2023-08-14 23:46:56 (9836): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-08-14 23:46:57 (9836): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2023-08-14 23:46:57 (9836): Guest Log: 2.5.2.0 4063 0 27544 21975 3 2 268678 4096000 0 65024 0 2 -100 7819 457 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-08-14 23:46:58 (9836): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-08-14 23:47:00 (9836): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2023-08-14 23:47:00 (9836): Guest Log: 2.5.2.0 4101 0 25440 268 3 1 268678 4096000 0 65024 0 0 n/a 4 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-08-14 23:47:01 (9836): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-08-14 23:47:02 (9836): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2023-08-14 23:47:02 (9836): Guest Log: 2.5.2.0 4149 0 35804 16354 3 1 268678 4096000 0 65024 0 0 n/a 4290 347 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-08-14 23:47:02 (9836): Guest Log: 08:47:01 CEST +02:00 2023-08-15: cranky: [INFO] Checking runc.
2023-08-14 23:47:02 (9836): Guest Log: 08:47:02 CEST +02:00 2023-08-15: cranky: [INFO] Creating the filesystem.
2023-08-14 23:47:03 (9836): Guest Log: 08:47:02 CEST +02:00 2023-08-15: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2023-08-14 23:47:03 (9836): Guest Log: 08:47:02 CEST +02:00 2023-08-15: cranky: [INFO] Updating config.json.
2023-08-14 23:47:03 (9836): Guest Log: 08:47:02 CEST +02:00 2023-08-15: cranky: [INFO] Running Container 'runc'.
2023-08-14 23:47:25 (9836): Guest Log: job: htmld=/shared/html/job
2023-08-14 23:47:25 (9836): Guest Log: job: unpack exitcode=0
2023-08-14 23:47:27 (9836): Guest Log: 08:47:26 CEST +02:00 2023-08-15: cranky: [INFO] ===> [runRivet] Tue Aug 15 06:47:24 UTC 2023 [boinc pp jets 8000 350 - pythia8 8.301 tune-A2 100000 526]
2023-08-14 23:50:13 (9836): Preference change detected
2023-08-14 23:50:13 (9836): Setting CPU throttle for VM. (100%)
2023-08-14 23:50:13 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-14 23:56:21 (9836): Preference change detected
2023-08-14 23:56:21 (9836): Setting CPU throttle for VM. (100%)
2023-08-14 23:56:21 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 00:23:31 (9836): Preference change detected
2023-08-15 00:23:31 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 00:23:32 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 00:42:18 (9836): Preference change detected
2023-08-15 00:42:18 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 00:42:18 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 01:07:28 (9836): Preference change detected
2023-08-15 01:07:28 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 01:07:29 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 01:10:48 (9836): Preference change detected
2023-08-15 01:10:48 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 01:10:48 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 01:17:02 (9836): Preference change detected
2023-08-15 01:17:02 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 01:17:02 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 01:26:47 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 01:26:47 (9836): Status Report: Elapsed Time: '6000.205204'
2023-08-15 01:26:47 (9836): Status Report: CPU Time: '3271.375000'
2023-08-15 02:32:39 (9836): Preference change detected
2023-08-15 02:32:39 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 02:32:39 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 02:44:55 (9836): Preference change detected
2023-08-15 02:44:55 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 02:44:55 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 03:06:52 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 03:06:52 (9836): Status Report: Elapsed Time: '12000.205204'
2023-08-15 03:06:52 (9836): Status Report: CPU Time: '9273.625000'
2023-08-15 03:42:09 (9836): Preference change detected
2023-08-15 03:42:09 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 03:42:10 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 03:55:30 (9836): Preference change detected
2023-08-15 03:55:30 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 03:55:30 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 03:55:43 (9836): Preference change detected
2023-08-15 03:55:43 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 03:55:43 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 03:56:07 (9836): Preference change detected
2023-08-15 03:56:07 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 03:56:07 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 03:56:20 (9836): Preference change detected
2023-08-15 03:56:20 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 03:56:20 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 03:56:33 (9836): Preference change detected
2023-08-15 03:56:33 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 03:56:33 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 04:46:57 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 04:46:57 (9836): Status Report: Elapsed Time: '18000.205204'
2023-08-15 04:46:57 (9836): Status Report: CPU Time: '15276.015625'
2023-08-15 04:49:37 (9836): Preference change detected
2023-08-15 04:49:37 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 04:49:37 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 06:27:02 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 06:27:02 (9836): Status Report: Elapsed Time: '24000.205204'
2023-08-15 06:27:02 (9836): Status Report: CPU Time: '21279.968750'
2023-08-15 06:59:59 (9836): Preference change detected
2023-08-15 06:59:59 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 07:00:00 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 08:07:06 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 08:07:06 (9836): Status Report: Elapsed Time: '30000.205204'
2023-08-15 08:07:06 (9836): Status Report: CPU Time: '27283.484375'
2023-08-15 09:47:11 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 09:47:11 (9836): Status Report: Elapsed Time: '36000.686941'
2023-08-15 09:47:11 (9836): Status Report: CPU Time: '33287.656250'
2023-08-15 10:49:16 (9836): Preference change detected
2023-08-15 10:49:16 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 10:49:16 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 10:49:49 (9836): Preference change detected
2023-08-15 10:49:49 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 10:49:49 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 10:53:18 (9836): Preference change detected
2023-08-15 10:53:18 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 10:53:18 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 11:27:15 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 11:27:15 (9836): Status Report: Elapsed Time: '42000.686941'
2023-08-15 11:27:15 (9836): Status Report: CPU Time: '39291.812500'
2023-08-15 13:07:20 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 13:07:20 (9836): Status Report: Elapsed Time: '48000.686941'
2023-08-15 13:07:20 (9836): Status Report: CPU Time: '45296.640625'
2023-08-15 13:48:18 (9836): Preference change detected
2023-08-15 13:48:18 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 13:48:19 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 13:48:30 (9836): Preference change detected
2023-08-15 13:48:30 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 13:48:31 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 13:48:42 (9836): Preference change detected
2023-08-15 13:48:42 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 13:48:43 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 14:47:24 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 14:47:24 (9836): Status Report: Elapsed Time: '54000.686941'
2023-08-15 14:47:24 (9836): Status Report: CPU Time: '51300.812500'
2023-08-15 16:27:28 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 16:27:28 (9836): Status Report: Elapsed Time: '60000.686941'
2023-08-15 16:27:28 (9836): Status Report: CPU Time: '57305.640625'
2023-08-15 18:07:33 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 18:07:33 (9836): Status Report: Elapsed Time: '66000.686941'
2023-08-15 18:07:33 (9836): Status Report: CPU Time: '63310.375000'
2023-08-15 18:48:35 (9836): Preference change detected
2023-08-15 18:48:35 (9836): Setting CPU throttle for VM. (100%)
2023-08-15 18:48:36 (9836): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2023-08-15 19:47:37 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 19:47:37 (9836): Status Report: Elapsed Time: '72000.686941'
2023-08-15 19:47:37 (9836): Status Report: CPU Time: '69315.343750'
2023-08-15 21:27:41 (9836): Status Report: Job Duration: '864000.000000'
2023-08-15 21:27:41 (9836): Status Report: Elapsed Time: '78000.686941'
2023-08-15 21:27:41 (9836): Status Report: CPU Time: '75320.593750'
2023-08-15 22:39:23 (9836): Guest Log: job: run exitcode=0
2023-08-15 22:39:23 (9836): Guest Log: job: diskusage=3040
2023-08-15 22:39:23 (9836): Guest Log: job: logsize=76 k
2023-08-15 22:39:23 (9836): Guest Log: job: times=
2023-08-15 22:39:23 (9836): Guest Log: 0m0.023s 0m0.027s
2023-08-15 22:39:23 (9836): Guest Log: 1312m4.824s 4m31.372s
2023-08-15 22:39:23 (9836): Guest Log: job: cpuusage=78996
2023-08-15 22:39:24 (9836): Guest Log: 07:39:23 CEST +02:00 2023-08-16: cranky: [INFO] Container 'runc' finished with status code 0.
2023-08-15 22:39:24 (9836): Guest Log: 07:39:23 CEST +02:00 2023-08-16: cranky: [INFO] Preparing output.
2023-08-15 22:39:25 (9836): Guest Log: [INFO] Job Finished
2023-08-15 22:39:25 (9836): Guest Log: [INFO] Shutting Down.
2023-08-15 22:39:25 (9836): VM Completion File Detected.
2023-08-15 22:39:25 (9836): VM Completion Message: Job Finished
.
2023-08-15 22:39:25 (9836): Powering off VM.
2023-08-15 22:39:26 (9836): Successfully stopped VM.
2023-08-15 22:39:26 (9836): Deregistering VM. (boinc_acee8369aab38bdf, slot#5)
2023-08-15 22:39:26 (9836): Removing network bandwidth throttle group from VM.
2023-08-15 22:39:26 (9836): Removing VM from VirtualBox.
22:39:32 (9836): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN